builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-039 starttime: 1496602675.46 results: success (0) revision: 8a3aa1701537ea6b8334f432cd030d260d492fa3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-04 11:57:55.459042) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-04 11:57:55.459512) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-04 11:57:55.459805) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-04 11:57:55.514891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-04 11:57:55.515212) ========= 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=5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-04 11:57:55-- 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% 42.7M=0s 2017-06-04 11:57:55 (42.7 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.185574 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-04 11:57:55.725325) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-04 11:57:55.728653) ========= 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=5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020104 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-04 11:57:55.778244) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-04 11:57:55.781643) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8a3aa1701537ea6b8334f432cd030d260d492fa3 --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 8a3aa1701537ea6b8334f432cd030d260d492fa3 --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=5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-04 11:57:55,868 truncating revision to first 12 chars 2017-06-04 11:57:55,868 Setting DEBUG logging. 2017-06-04 11:57:55,868 attempt 1/10 2017-06-04 11:57:55,868 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8a3aa1701537?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-04 11:57:56,181 unpacking tar archive at: mozilla-central-8a3aa1701537/testing/mozharness/ program finished with exit code 0 elapsedTime=0.619243 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-04 11:57:56.413180) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-04 11:57:56.416508) ========= script_repo_revision: 8a3aa1701537ea6b8334f432cd030d260d492fa3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-04 11:57:56.416913) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-04 11:57:56.417190) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-04 11:57:56.425825) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2017-06-04 11:57:56.426101) ========= /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=5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:57:56 INFO - MultiFileLogger online at 20170604 11:57:56 in /builds/slave/test 11:57:56 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 11:57:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:57:56 INFO - {'append_to_log': False, 11:57:56 INFO - 'base_work_dir': '/builds/slave/test', 11:57:56 INFO - 'blob_upload_branch': 'Firefox', 11:57:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:57:56 INFO - 'branch': 'Firefox', 11:57:56 INFO - 'buildbot_json_path': 'buildprops.json', 11:57:56 INFO - 'config_files': ('talos/linux_config.py',), 11:57:56 INFO - 'default_actions': ('clobber', 11:57:56 INFO - 'read-buildbot-config', 11:57:56 INFO - 'download-and-extract', 11:57:56 INFO - 'populate-webroot', 11:57:56 INFO - 'create-virtualenv', 11:57:56 INFO - 'install', 11:57:56 INFO - 'setup-mitmproxy', 11:57:56 INFO - 'run-tests'), 11:57:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:57:56 INFO - 'download_minidump_stackwalk': True, 11:57:56 INFO - 'download_symbols': 'ondemand', 11:57:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:57:56 INFO - 'tooltool.py': '/tools/tooltool.py', 11:57:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:57:56 INFO - '/tools/misc-python/virtualenv.py')}, 11:57:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:57:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:57:56 INFO - 'gecko_profile': False, 11:57:56 INFO - 'gecko_profile_interval': 0, 11:57:56 INFO - 'installer_path': 'installer.exe', 11:57:56 INFO - 'log_level': 'info', 11:57:56 INFO - 'log_name': 'talos', 11:57:56 INFO - 'log_to_console': True, 11:57:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:57:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:57:56 INFO - 'opt_config_files': (), 11:57:56 INFO - 'pip_index': False, 11:57:56 INFO - 'suite': 'dromaeojs-e10s', 11:57:56 INFO - 'system_bits': '32', 11:57:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:57:56 INFO - 'title': 'talos-linux64-ix-039', 11:57:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:57:56 INFO - 'use_talos_json': True, 11:57:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:57:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:57:56 INFO - 'work_dir': 'build'} 11:57:56 INFO - [mozharness: 2017-06-04 18:57:56.717926Z] Running clobber step. 11:57:56 INFO - Running pre-action listener: _resource_record_pre_action 11:57:56 INFO - Running main action method: clobber 11:57:56 INFO - rmtree: /builds/slave/test/build 11:57:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:57:57 INFO - Running post-action listener: _resource_record_post_action 11:57:57 INFO - [mozharness: 2017-06-04 18:57:57.701809Z] Finished clobber step (success) 11:57:57 INFO - [mozharness: 2017-06-04 18:57:57.701912Z] Running read-buildbot-config step. 11:57:57 INFO - Running pre-action listener: _resource_record_pre_action 11:57:57 INFO - Running main action method: read_buildbot_config 11:57:57 INFO - Using buildbot properties: 11:57:57 INFO - { 11:57:57 INFO - "project": "", 11:57:57 INFO - "product": "firefox", 11:57:57 INFO - "who": "archaeopteryx@coole-files.de", 11:57:57 INFO - "installer_path": "public/build/target.tar.bz2", 11:57:57 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 11:57:57 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 11:57:57 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 11:57:57 INFO - "stage_platform": "linux64-stylosequential", 11:57:57 INFO - "basedir": "/builds/slave/test", 11:57:57 INFO - "buildnumber": 49, 11:57:57 INFO - "platform": "ubuntu64_hw_styloseq", 11:57:57 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:57:57 INFO - "slavebuilddir": "test", 11:57:57 INFO - "taskId": "ZCm4y5BvQ5mC5OV5UtZ10A", 11:57:57 INFO - "branch": "mozilla-central", 11:57:57 INFO - "script_repo_revision": "production", 11:57:57 INFO - "revision": "8a3aa1701537ea6b8334f432cd030d260d492fa3", 11:57:57 INFO - "slavename": "talos-linux64-ix-039", 11:57:57 INFO - "repo_path": "mozilla-central" 11:57:57 INFO - } 11:57:57 INFO - Finding installer, test and symbols from parent task. 11:57:57 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZCm4y5BvQ5mC5OV5UtZ10A'}, attempt #1 11:57:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZCm4y5BvQ5mC5OV5UtZ10A'}, attempt #1 11:57:58 INFO - Task dependencies: XeTiw3l4Tp6sQcvKcQ0p-w 11:57:58 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XeTiw3l4Tp6sQcvKcQ0p-w'}, attempt #1 11:57:59 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/target.tar.bz2 11:57:59 INFO - Set test_url: https://queue.taskcluster.net/v1/task/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/test_packages.json 11:57:59 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/target.crashreporter-symbols.zip 11:57:59 INFO - Running post-action listener: _resource_record_post_action 11:57:59 INFO - [mozharness: 2017-06-04 18:57:59.093097Z] Finished read-buildbot-config step (success) 11:57:59 INFO - [mozharness: 2017-06-04 18:57:59.093324Z] Running download-and-extract step. 11:57:59 INFO - Running pre-action listener: _resource_record_pre_action 11:57:59 INFO - Running main action method: download_and_extract 11:57:59 INFO - mkdir: /builds/slave/test/build/tests 11:57:59 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')]} 11:57:59 INFO - trying https://queue.taskcluster.net/v1/task/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/target.test_packages.json 11:57:59 INFO - Downloading https://queue.taskcluster.net/v1/task/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 11:57:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 11:57:59 INFO - Downloaded 989 bytes. 11:57:59 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 11:57:59 INFO - Using the following test package requirements: 11:57:59 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 11:57:59 INFO - u'common': [u'target.common.tests.zip'], 11:57:59 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 11:57:59 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 11:57:59 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 11:57:59 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 11:57:59 INFO - u'mozbase': [u'target.common.tests.zip'], 11:57:59 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 11:57:59 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 11:57:59 INFO - u'web-platform': [u'target.common.tests.zip', 11:57:59 INFO - u'target.web-platform.tests.tar.gz'], 11:57:59 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 11:57:59 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 11:57:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/target.common.tests.zip 11:57:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:57:59 INFO - Fetch https://queue.taskcluster.net/v1/task/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/target.common.tests.zip into memory 11:58:00 INFO - Content-Length response header: 65102491 11:58:00 INFO - Bytes received: 65102491 11:58:12 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 11:58:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/target.common.tests.zip 11:58:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/target.common.tests.zip'}, attempt #1 11:58:12 INFO - Fetch https://queue.taskcluster.net/v1/task/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/target.common.tests.zip into memory 11:58:13 INFO - Content-Length response header: 65102491 11:58:13 INFO - Bytes received: 65102491 11:58:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/target.talos.tests.zip 11:58:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 11:58:26 INFO - Fetch https://queue.taskcluster.net/v1/task/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/target.talos.tests.zip into memory 11:58:26 INFO - Content-Length response header: 14447425 11:58:26 INFO - Bytes received: 14447425 11:58:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:27 INFO - trying https://queue.taskcluster.net/v1/task/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/target.tar.bz2 11:58:27 INFO - Downloading https://queue.taskcluster.net/v1/task/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 11:58:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 11:58:28 INFO - Downloaded 60387020 bytes. 11:58:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/target.tar.bz2 11:58:28 INFO - mkdir: /builds/slave/test/properties 11:58:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:58:28 INFO - Writing to file /builds/slave/test/properties/build_url 11:58:28 INFO - Contents: 11:58:28 INFO - build_url:https://queue.taskcluster.net/v1/task/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/target.tar.bz2 11:58:28 INFO - Running post-action listener: _resource_record_post_action 11:58:28 INFO - Running post-action listener: set_extra_try_arguments 11:58:28 INFO - [mozharness: 2017-06-04 18:58:28.098681Z] Finished download-and-extract step (success) 11:58:28 INFO - [mozharness: 2017-06-04 18:58:28.098779Z] Running populate-webroot step. 11:58:28 INFO - Running pre-action listener: _resource_record_pre_action 11:58:28 INFO - Running main action method: populate_webroot 11:58:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:58:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:58:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:58:28 INFO - '--tppagecycles', 11:58:28 INFO - '7'], 11:58:28 INFO - 'tests': ['tsvgm']}}, 11:58:28 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:58:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:58:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:58:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:58:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 11:58:28 INFO - 'talos_options': ['--disable-e10s'], 11:58:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:58:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 11:58:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:58:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 11:58:28 INFO - 'talos_options': ['--disable-e10s'], 11:58:28 INFO - 'tests': ['damp', 'tps']}, 11:58:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 11:58:28 INFO - 'tests': ['damp', 'tps']}, 11:58:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:58:28 INFO - 'tests': ['dromaeo_dom']}, 11:58:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:58:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:58:28 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 11:58:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 11:58:28 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 11:58:28 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 11:58:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:58:28 INFO - 'tests': ['a11yr', 11:58:28 INFO - 'ts_paint', 11:58:28 INFO - 'tpaint', 11:58:28 INFO - 'sessionrestore', 11:58:28 INFO - 'sessionrestore_no_auto_restore', 11:58:28 INFO - 'tabpaint']}, 11:58:28 INFO - 'other-e10s': {'tests': ['a11yr', 11:58:28 INFO - 'ts_paint', 11:58:28 INFO - 'tpaint', 11:58:28 INFO - 'sessionrestore', 11:58:28 INFO - 'sessionrestore_no_auto_restore', 11:58:28 INFO - 'tabpaint']}, 11:58:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:58:28 INFO - 'ts_paint', 11:58:28 INFO - 'tpaint', 11:58:28 INFO - 'sessionrestore', 11:58:28 INFO - 'sessionrestore_no_auto_restore', 11:58:28 INFO - 'tabpaint']}, 11:58:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:58:28 INFO - 'ts_paint', 11:58:28 INFO - 'tpaint', 11:58:28 INFO - 'sessionrestore', 11:58:28 INFO - 'sessionrestore_no_auto_restore', 11:58:28 INFO - 'tabpaint']}, 11:58:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:58:28 INFO - 'tests': ['a11yr', 11:58:28 INFO - 'ts_paint', 11:58:28 INFO - 'tpaint', 11:58:28 INFO - 'sessionrestore', 11:58:28 INFO - 'sessionrestore_no_auto_restore', 11:58:28 INFO - 'tabpaint']}, 11:58:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:58:28 INFO - 'tests': ['a11yr', 11:58:28 INFO - 'ts_paint', 11:58:28 INFO - 'tpaint', 11:58:28 INFO - 'sessionrestore', 11:58:28 INFO - 'sessionrestore_no_auto_restore', 11:58:28 INFO - 'tabpaint']}, 11:58:28 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 11:58:28 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 11:58:28 INFO - 'bloom_basic_ref']}, 11:58:28 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 11:58:28 INFO - 'talos_options': ['--mitmproxy', 11:58:28 INFO - 'mitmproxy-recording-1.mp', 11:58:28 INFO - '--firstNonBlankPaint'], 11:58:28 INFO - 'tests': ['Quantum_1']}, 11:58:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:58:28 INFO - 'tests': ['tsvgx', 11:58:28 INFO - 'tsvgr_opacity', 11:58:28 INFO - 'tart', 11:58:28 INFO - 'tscrollx', 11:58:28 INFO - 'cart', 11:58:28 INFO - 'tsvg_static']}, 11:58:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:58:28 INFO - 'tsvgr_opacity', 11:58:28 INFO - 'tart', 11:58:28 INFO - 'tscrollx', 11:58:28 INFO - 'cart', 11:58:28 INFO - 'tsvg_static']}, 11:58:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 11:58:28 INFO - 'talos_options': ['--disable-e10s'], 11:58:28 INFO - 'tests': ['tp5o']}, 11:58:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 11:58:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 11:58:28 INFO - 'talos_options': ['--disable-e10s', 11:58:28 INFO - '--xperf_path', 11:58:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:58:28 INFO - 'tests': ['tp5n']}, 11:58:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 11:58:28 INFO - 'talos_options': ['--xperf_path', 11:58:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:58:28 INFO - 'tests': ['tp5n']}}, 11:58:28 INFO - 'talos.zip': {'path': '', 11:58:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:58:28 INFO - Running post-action listener: _resource_record_post_action 11:58:28 INFO - [mozharness: 2017-06-04 18:58:28.113101Z] Finished populate-webroot step (success) 11:58:28 INFO - [mozharness: 2017-06-04 18:58:28.113191Z] Running create-virtualenv step. 11:58:28 INFO - Running pre-action listener: _resource_record_pre_action 11:58:28 INFO - Running main action method: create_virtualenv 11:58:28 INFO - Creating virtualenv /builds/slave/test/build/venv 11:58:28 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 11:58:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:58:28 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 11:58:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:58:28 INFO - Using real prefix '/usr' 11:58:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:58:28 INFO - Installing distribute.............................................................................................................................................................................................done. 11:58:30 INFO - Installing pip.................done. 11:58:30 INFO - Return code: 0 11:58:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 11:58:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 11:58:31 INFO - Reading from file tmpfile_stdout 11:58:31 INFO - Output received: 11:58:31 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) 11:58:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:58:31 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')]} 11:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:31 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')]} 11:58:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:31 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 0xd383b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf12a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3840>, '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 0x10b4740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4bd0>, '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': '5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233', '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 11:58:31 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 11:58:31 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 11:58:31 INFO - Using env: {'DISPLAY': ':0', 11:58:31 INFO - 'HOME': '/home/cltbld', 11:58:31 INFO - 'LANG': 'en_US.UTF-8', 11:58:31 INFO - 'LANGUAGE': 'en_US:en', 11:58:31 INFO - 'LOGNAME': 'cltbld', 11:58:31 INFO - 'MAIL': '/var/mail/cltbld', 11:58:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:31 INFO - 'MOZ_NO_REMOTE': '1', 11:58:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:31 INFO - 'NO_EM_RESTART': '1', 11:58:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:31 INFO - 'PWD': '/builds/slave/test', 11:58:31 INFO - 'SHELL': '/bin/bash', 11:58:31 INFO - 'SHLVL': '1', 11:58:31 INFO - 'TERM': 'linux', 11:58:31 INFO - 'TMOUT': '86400', 11:58:31 INFO - 'USER': 'cltbld', 11:58:31 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233', 11:58:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:31 INFO - '_': '/tools/buildbot/bin/python'} 11:58:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:31 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 11:58:31 INFO - Cleaning up... 11:58:31 INFO - Return code: 0 11:58:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:58:31 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')]} 11:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:31 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')]} 11:58:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:31 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 0xd383b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf12a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3840>, '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 0x10b4740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4bd0>, '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': '5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233', '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 11:58:31 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 11:58:31 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 11:58:31 INFO - Using env: {'DISPLAY': ':0', 11:58:31 INFO - 'HOME': '/home/cltbld', 11:58:31 INFO - 'LANG': 'en_US.UTF-8', 11:58:31 INFO - 'LANGUAGE': 'en_US:en', 11:58:31 INFO - 'LOGNAME': 'cltbld', 11:58:31 INFO - 'MAIL': '/var/mail/cltbld', 11:58:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:31 INFO - 'MOZ_NO_REMOTE': '1', 11:58:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:31 INFO - 'NO_EM_RESTART': '1', 11:58:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:31 INFO - 'PWD': '/builds/slave/test', 11:58:31 INFO - 'SHELL': '/bin/bash', 11:58:31 INFO - 'SHLVL': '1', 11:58:31 INFO - 'TERM': 'linux', 11:58:31 INFO - 'TMOUT': '86400', 11:58:31 INFO - 'USER': 'cltbld', 11:58:31 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233', 11:58:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:31 INFO - '_': '/tools/buildbot/bin/python'} 11:58:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:31 INFO - Downloading/unpacking psutil>=3.1.1 11:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:58:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:58:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:58:32 INFO - Installing collected packages: psutil 11:58:32 INFO - Running setup.py install for psutil 11:58:32 INFO - building 'psutil._psutil_linux' extension 11:58:32 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 11:58:33 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 11:58:33 INFO - building 'psutil._psutil_posix' extension 11:58:33 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 11:58:33 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 11:58:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:58:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:58:34 INFO - Successfully installed psutil 11:58:34 INFO - Cleaning up... 11:58:34 INFO - Return code: 0 11:58:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd383b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf12a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3840>, '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 0x10b4740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4bd0>, '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': '5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233', '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 11:58:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 11:58:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 11:58:34 INFO - Using env: {'DISPLAY': ':0', 11:58:34 INFO - 'HOME': '/home/cltbld', 11:58:34 INFO - 'LANG': 'en_US.UTF-8', 11:58:34 INFO - 'LANGUAGE': 'en_US:en', 11:58:34 INFO - 'LOGNAME': 'cltbld', 11:58:34 INFO - 'MAIL': '/var/mail/cltbld', 11:58:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:34 INFO - 'MOZ_NO_REMOTE': '1', 11:58:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:34 INFO - 'NO_EM_RESTART': '1', 11:58:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:34 INFO - 'PWD': '/builds/slave/test', 11:58:34 INFO - 'SHELL': '/bin/bash', 11:58:34 INFO - 'SHLVL': '1', 11:58:34 INFO - 'TERM': 'linux', 11:58:34 INFO - 'TMOUT': '86400', 11:58:34 INFO - 'USER': 'cltbld', 11:58:34 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233', 11:58:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:34 INFO - '_': '/tools/buildbot/bin/python'} 11:58:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:58:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:58:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:58:35 INFO - Installing collected packages: mozsystemmonitor 11:58:35 INFO - Running setup.py install for mozsystemmonitor 11:58:35 INFO - Successfully installed mozsystemmonitor 11:58:35 INFO - Cleaning up... 11:58:35 INFO - Return code: 0 11:58:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:58:35 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')]} 11:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:35 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')]} 11:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:35 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 0xd383b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf12a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3840>, '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 0x10b4740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4bd0>, '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': '5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233', '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 11:58:35 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 11:58:35 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 11:58:35 INFO - Using env: {'DISPLAY': ':0', 11:58:35 INFO - 'HOME': '/home/cltbld', 11:58:35 INFO - 'LANG': 'en_US.UTF-8', 11:58:35 INFO - 'LANGUAGE': 'en_US:en', 11:58:35 INFO - 'LOGNAME': 'cltbld', 11:58:35 INFO - 'MAIL': '/var/mail/cltbld', 11:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:35 INFO - 'MOZ_NO_REMOTE': '1', 11:58:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:35 INFO - 'NO_EM_RESTART': '1', 11:58:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:35 INFO - 'PWD': '/builds/slave/test', 11:58:35 INFO - 'SHELL': '/bin/bash', 11:58:35 INFO - 'SHLVL': '1', 11:58:35 INFO - 'TERM': 'linux', 11:58:35 INFO - 'TMOUT': '86400', 11:58:35 INFO - 'USER': 'cltbld', 11:58:35 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233', 11:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:35 INFO - '_': '/tools/buildbot/bin/python'} 11:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:35 INFO - Downloading/unpacking jsonschema==2.5.1 11:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:58:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:58:36 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 11:58:36 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 11:58:36 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 11:58:36 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 11:58:37 INFO - Downloading functools32-3.2.3-2.tar.gz 11:58:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:58:37 INFO - warning: no files found matching '*.txt' 11:58:37 INFO - no previously-included directories found matching 'build' 11:58:37 INFO - no previously-included directories found matching 'dist' 11:58:37 INFO - no previously-included directories found matching '.git*' 11:58:37 INFO - Installing collected packages: jsonschema, functools32 11:58:37 INFO - Running setup.py install for functools32 11:58:37 INFO - warning: no files found matching '*.txt' 11:58:37 INFO - no previously-included directories found matching 'build' 11:58:37 INFO - no previously-included directories found matching 'dist' 11:58:37 INFO - no previously-included directories found matching '.git*' 11:58:37 INFO - Successfully installed jsonschema functools32 11:58:37 INFO - Cleaning up... 11:58:37 INFO - Return code: 0 11:58:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:58:37 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')]} 11:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:37 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')]} 11:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:37 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 0xd383b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf12a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3840>, '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 0x10b4740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4bd0>, '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': '5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233', '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 11:58:37 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 11:58:37 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 11:58:37 INFO - Using env: {'DISPLAY': ':0', 11:58:37 INFO - 'HOME': '/home/cltbld', 11:58:37 INFO - 'LANG': 'en_US.UTF-8', 11:58:37 INFO - 'LANGUAGE': 'en_US:en', 11:58:37 INFO - 'LOGNAME': 'cltbld', 11:58:37 INFO - 'MAIL': '/var/mail/cltbld', 11:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:37 INFO - 'MOZ_NO_REMOTE': '1', 11:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:37 INFO - 'NO_EM_RESTART': '1', 11:58:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:37 INFO - 'PWD': '/builds/slave/test', 11:58:37 INFO - 'SHELL': '/bin/bash', 11:58:37 INFO - 'SHLVL': '1', 11:58:37 INFO - 'TERM': 'linux', 11:58:37 INFO - 'TMOUT': '86400', 11:58:37 INFO - 'USER': 'cltbld', 11:58:37 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233', 11:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:37 INFO - '_': '/tools/buildbot/bin/python'} 11:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:58:37 INFO - Cleaning up... 11:58:37 INFO - Return code: 0 11:58:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:58:37 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')]} 11:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:37 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')]} 11:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:37 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 0xd383b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf12a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3840>, '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 0x10b4740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4bd0>, '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': '5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233', '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 11:58:37 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 11:58:37 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 11:58:37 INFO - Using env: {'DISPLAY': ':0', 11:58:37 INFO - 'HOME': '/home/cltbld', 11:58:37 INFO - 'LANG': 'en_US.UTF-8', 11:58:37 INFO - 'LANGUAGE': 'en_US:en', 11:58:37 INFO - 'LOGNAME': 'cltbld', 11:58:37 INFO - 'MAIL': '/var/mail/cltbld', 11:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:37 INFO - 'MOZ_NO_REMOTE': '1', 11:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:37 INFO - 'NO_EM_RESTART': '1', 11:58:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:37 INFO - 'PWD': '/builds/slave/test', 11:58:37 INFO - 'SHELL': '/bin/bash', 11:58:37 INFO - 'SHLVL': '1', 11:58:37 INFO - 'TERM': 'linux', 11:58:37 INFO - 'TMOUT': '86400', 11:58:37 INFO - 'USER': 'cltbld', 11:58:37 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233', 11:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:37 INFO - '_': '/tools/buildbot/bin/python'} 11:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:37 INFO - Downloading/unpacking blobuploader==1.2.4 11:58:37 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 11:58:37 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 11:58:37 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 11:58:37 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 11:58:38 INFO - Downloading blobuploader-1.2.4.tar.gz 11:58:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:58:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:58:38 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 11:58:38 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 11:58:38 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 11:58:38 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 11:58:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:58:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:58:39 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 11:58:39 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 11:58:39 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 11:58:39 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 11:58:39 INFO - Downloading docopt-0.6.1.tar.gz 11:58:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:58:39 INFO - Installing collected packages: blobuploader, requests, docopt 11:58:39 INFO - Running setup.py install for blobuploader 11:58:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:58:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:58:39 INFO - Running setup.py install for requests 11:58:39 INFO - Running setup.py install for docopt 11:58:39 INFO - Successfully installed blobuploader requests docopt 11:58:39 INFO - Cleaning up... 11:58:40 INFO - Return code: 0 11:58:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:40 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 0xd383b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf12a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3840>, '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 0x10b4740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4bd0>, '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': '5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233', '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 11:58:40 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 11:58:40 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 11:58:40 INFO - Using env: {'DISPLAY': ':0', 11:58:40 INFO - 'HOME': '/home/cltbld', 11:58:40 INFO - 'LANG': 'en_US.UTF-8', 11:58:40 INFO - 'LANGUAGE': 'en_US:en', 11:58:40 INFO - 'LOGNAME': 'cltbld', 11:58:40 INFO - 'MAIL': '/var/mail/cltbld', 11:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:40 INFO - 'MOZ_NO_REMOTE': '1', 11:58:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:40 INFO - 'NO_EM_RESTART': '1', 11:58:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:40 INFO - 'PWD': '/builds/slave/test', 11:58:40 INFO - 'SHELL': '/bin/bash', 11:58:40 INFO - 'SHLVL': '1', 11:58:40 INFO - 'TERM': 'linux', 11:58:40 INFO - 'TMOUT': '86400', 11:58:40 INFO - 'USER': 'cltbld', 11:58:40 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233', 11:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:40 INFO - '_': '/tools/buildbot/bin/python'} 11:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:58:40 INFO - Running setup.py (path:/tmp/pip-eZ5fPG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:58:40 INFO - Running setup.py (path:/tmp/pip-aCI8kJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:58:40 INFO - Running setup.py (path:/tmp/pip-2H7rMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:58:40 INFO - Running setup.py (path:/tmp/pip-iyT_hx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:58:40 INFO - Running setup.py (path:/tmp/pip-gjp4sV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:58:40 INFO - Running setup.py (path:/tmp/pip-P6HdzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:58:40 INFO - Running setup.py (path:/tmp/pip-5TEcRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:58:40 INFO - Running setup.py (path:/tmp/pip-xuiZT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:58:40 INFO - Running setup.py (path:/tmp/pip-IdaScC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:58:40 INFO - Running setup.py (path:/tmp/pip-LAftzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:58:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:58:40 INFO - Running setup.py (path:/tmp/pip-WWpihA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:58:41 INFO - Running setup.py (path:/tmp/pip-pH2fdS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:58:41 INFO - Running setup.py (path:/tmp/pip-FD2tBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:58:41 INFO - Running setup.py (path:/tmp/pip-92cR_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:41 INFO - Running setup.py (path:/tmp/pip-SN6HF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:58:41 INFO - Running setup.py (path:/tmp/pip-iGgkBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:58:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:58:41 INFO - Running setup.py (path:/tmp/pip-tHqzQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:58:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:58:41 INFO - Running setup.py install for manifestparser 11:58:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:58:41 INFO - Running setup.py install for mozcrash 11:58:41 INFO - Running setup.py install for mozdebug 11:58:41 INFO - Running setup.py install for mozdevice 11:58:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:58:41 INFO - Running setup.py install for mozfile 11:58:41 INFO - Running setup.py install for mozhttpd 11:58:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:58:42 INFO - Running setup.py install for mozinfo 11:58:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:58:42 INFO - Running setup.py install for mozInstall 11:58:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:58:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:58:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:58:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:58:42 INFO - Running setup.py install for mozleak 11:58:42 INFO - Running setup.py install for mozlog 11:58:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:58:42 INFO - Running setup.py install for moznetwork 11:58:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:58:42 INFO - Running setup.py install for mozprocess 11:58:42 INFO - Running setup.py install for mozprofile 11:58:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:58:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:58:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:58:42 INFO - Running setup.py install for mozrunner 11:58:42 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:58:42 INFO - Running setup.py install for mozscreenshot 11:58:43 INFO - Running setup.py install for moztest 11:58:43 INFO - Running setup.py install for mozversion 11:58:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:58:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:58:43 INFO - Cleaning up... 11:58:43 INFO - Return code: 0 11:58:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:43 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 0xd383b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf12a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3840>, '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 0x10b4740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4bd0>, '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': '5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233', '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 11:58:43 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 11:58:43 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 11:58:43 INFO - Using env: {'DISPLAY': ':0', 11:58:43 INFO - 'HOME': '/home/cltbld', 11:58:43 INFO - 'LANG': 'en_US.UTF-8', 11:58:43 INFO - 'LANGUAGE': 'en_US:en', 11:58:43 INFO - 'LOGNAME': 'cltbld', 11:58:43 INFO - 'MAIL': '/var/mail/cltbld', 11:58:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:43 INFO - 'MOZ_NO_REMOTE': '1', 11:58:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:43 INFO - 'NO_EM_RESTART': '1', 11:58:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:43 INFO - 'PWD': '/builds/slave/test', 11:58:43 INFO - 'SHELL': '/bin/bash', 11:58:43 INFO - 'SHLVL': '1', 11:58:43 INFO - 'TERM': 'linux', 11:58:43 INFO - 'TMOUT': '86400', 11:58:43 INFO - 'USER': 'cltbld', 11:58:43 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233', 11:58:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:43 INFO - '_': '/tools/buildbot/bin/python'} 11:58:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:58:43 INFO - Running setup.py (path:/tmp/pip-9qewwx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:58:43 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)) 11:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:58:43 INFO - Running setup.py (path:/tmp/pip-VOpPMO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:58:43 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)) 11:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:58:43 INFO - Running setup.py (path:/tmp/pip-YmOWQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:58:43 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)) 11:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:58:43 INFO - Running setup.py (path:/tmp/pip-XEEqRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:58:43 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)) 11:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:58:43 INFO - Running setup.py (path:/tmp/pip-0FGGcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:58:43 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)) 11:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:58:43 INFO - Running setup.py (path:/tmp/pip-BeEEU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:58:43 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)) 11:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:58:43 INFO - Running setup.py (path:/tmp/pip-WsuAHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:58:43 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)) 11:58:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:58:44 INFO - Running setup.py (path:/tmp/pip-ESHLC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:58:44 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)) 11:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:58:44 INFO - Running setup.py (path:/tmp/pip-ipsYlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:58:44 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)) 11:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:58:44 INFO - Running setup.py (path:/tmp/pip-8Ezud9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:58:44 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)) 11:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:58:44 INFO - Running setup.py (path:/tmp/pip-O7lZrd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:58:44 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)) 11:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:58:44 INFO - Running setup.py (path:/tmp/pip-J9crdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:58:44 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)) 11:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:58:44 INFO - Running setup.py (path:/tmp/pip-5g6MkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:58:44 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)) 11:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:58:44 INFO - Running setup.py (path:/tmp/pip-JrRijX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:58:44 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)) 11:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:44 INFO - Running setup.py (path:/tmp/pip-3OeLLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:58:44 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)) 11:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:58:44 INFO - Running setup.py (path:/tmp/pip-YRFoVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:58:44 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)) 11:58:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:58:44 INFO - Running setup.py (path:/tmp/pip-Wflxgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:58:44 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)) 11:58:44 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)) 11:58:44 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)) 11:58:44 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)) 11:58:44 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)) 11:58:44 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)) 11:58:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:45 INFO - Downloading blessings-1.6.tar.gz 11:58:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:58:45 INFO - Installing collected packages: blessings 11:58:45 INFO - Running setup.py install for blessings 11:58:46 INFO - Successfully installed blessings 11:58:46 INFO - Cleaning up... 11:58:46 INFO - Return code: 0 11:58:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:58:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:58:46 INFO - Reading from file tmpfile_stdout 11:58:46 INFO - Current package versions: 11:58:46 INFO - argparse == 1.2.1 11:58:46 INFO - blessings == 1.6 11:58:46 INFO - blobuploader == 1.2.4 11:58:46 INFO - docopt == 0.6.1 11:58:46 INFO - functools32 == 3.2.3-2 11:58:46 INFO - jsonschema == 2.5.1 11:58:46 INFO - manifestparser == 1.1 11:58:46 INFO - mozInstall == 1.12 11:58:46 INFO - mozcrash == 1.0 11:58:46 INFO - mozdebug == 0.1 11:58:46 INFO - mozdevice == 0.51 11:58:46 INFO - mozfile == 1.2 11:58:46 INFO - mozhttpd == 0.7 11:58:46 INFO - mozinfo == 0.9 11:58:46 INFO - mozleak == 0.1 11:58:46 INFO - mozlog == 3.4 11:58:46 INFO - moznetwork == 0.27 11:58:46 INFO - mozprocess == 0.25 11:58:46 INFO - mozprofile == 0.28 11:58:46 INFO - mozrunner == 6.13 11:58:46 INFO - mozscreenshot == 0.1 11:58:46 INFO - mozsystemmonitor == 0.3 11:58:46 INFO - moztest == 0.8 11:58:46 INFO - mozversion == 1.4 11:58:46 INFO - psutil == 3.1.1 11:58:46 INFO - requests == 1.2.3 11:58:46 INFO - wsgiref == 0.1.2 11:58:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:58:46 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')]} 11:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:46 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')]} 11:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:46 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 0xd383b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf12a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3840>, '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 0x10b4740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4bd0>, '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': '5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233', '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 11:58:46 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 11:58:46 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 11:58:46 INFO - Using env: {'DISPLAY': ':0', 11:58:46 INFO - 'HOME': '/home/cltbld', 11:58:46 INFO - 'LANG': 'en_US.UTF-8', 11:58:46 INFO - 'LANGUAGE': 'en_US:en', 11:58:46 INFO - 'LOGNAME': 'cltbld', 11:58:46 INFO - 'MAIL': '/var/mail/cltbld', 11:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:46 INFO - 'MOZ_NO_REMOTE': '1', 11:58:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:46 INFO - 'NO_EM_RESTART': '1', 11:58:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:46 INFO - 'PWD': '/builds/slave/test', 11:58:46 INFO - 'SHELL': '/bin/bash', 11:58:46 INFO - 'SHLVL': '1', 11:58:46 INFO - 'TERM': 'linux', 11:58:46 INFO - 'TMOUT': '86400', 11:58:46 INFO - 'USER': 'cltbld', 11:58:46 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233', 11:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:46 INFO - '_': '/tools/buildbot/bin/python'} 11:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:46 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)) 11:58:46 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)) 11:58:46 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)) 11:58:46 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)) 11:58:46 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)) 11:58:46 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)) 11:58:46 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)) 11:58:46 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)) 11:58:46 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)) 11:58:46 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 11:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:58:47 INFO - Downloading marionette_driver-1.4.0.tar.gz 11:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 11:58:47 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)) 11:58:47 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)) 11:58:47 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)) 11:58:47 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)) 11:58:47 INFO - Installing collected packages: marionette-driver 11:58:47 INFO - Running setup.py install for marionette-driver 11:58:47 INFO - Successfully installed marionette-driver 11:58:47 INFO - Cleaning up... 11:58:47 INFO - Return code: 0 11:58:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:58:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:58:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd383b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf12a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b6dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b3840>, '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 0x10b4740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4bd0>, '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': '5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233', '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 11:58:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 11:58:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 11:58:47 INFO - Using env: {'DISPLAY': ':0', 11:58:47 INFO - 'HOME': '/home/cltbld', 11:58:47 INFO - 'LANG': 'en_US.UTF-8', 11:58:47 INFO - 'LANGUAGE': 'en_US:en', 11:58:47 INFO - 'LOGNAME': 'cltbld', 11:58:47 INFO - 'MAIL': '/var/mail/cltbld', 11:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:58:47 INFO - 'MOZ_NO_REMOTE': '1', 11:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:58:47 INFO - 'NO_EM_RESTART': '1', 11:58:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:58:47 INFO - 'PWD': '/builds/slave/test', 11:58:47 INFO - 'SHELL': '/bin/bash', 11:58:47 INFO - 'SHLVL': '1', 11:58:47 INFO - 'TERM': 'linux', 11:58:47 INFO - 'TMOUT': '86400', 11:58:47 INFO - 'USER': 'cltbld', 11:58:47 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233', 11:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:58:47 INFO - '_': '/tools/buildbot/bin/python'} 11:58:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:58:48 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:58:48 INFO - Cleaning up... 11:58:48 INFO - Return code: 0 11:58:48 INFO - Running post-action listener: _resource_record_post_action 11:58:48 INFO - Running post-action listener: _start_resource_monitoring 11:58:48 INFO - Starting resource monitoring. 11:58:48 INFO - [mozharness: 2017-06-04 18:58:48.102836Z] Finished create-virtualenv step (success) 11:58:48 INFO - [mozharness: 2017-06-04 18:58:48.103783Z] Running install step. 11:58:48 INFO - Running pre-action listener: _resource_record_pre_action 11:58:48 INFO - Running main action method: install 11:58:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:58:48 INFO - Reading from file tmpfile_stdout 11:58:48 INFO - Detecting whether we're running mozinstall >=1.0... 11:58:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:58:48 INFO - Reading from file tmpfile_stdout 11:58:48 INFO - Output received: 11:58:48 INFO - Usage: mozinstall [options] installer 11:58:48 INFO - Options: 11:58:48 INFO - -h, --help show this help message and exit 11:58:48 INFO - -d DEST, --destination=DEST 11:58:48 INFO - Directory to install application into. [default: 11:58:48 INFO - "/builds/slave/test"] 11:58:48 INFO - --app=APP Application being installed. [default: firefox] 11:58:48 INFO - mkdir: /builds/slave/test/build/application 11:58:48 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'] 11:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 11:59:05 INFO - Reading from file tmpfile_stdout 11:59:05 INFO - Output received: 11:59:05 INFO - /builds/slave/test/build/application/firefox/firefox 11:59:05 INFO - Running post-action listener: _resource_record_post_action 11:59:05 INFO - [mozharness: 2017-06-04 18:59:05.848084Z] Finished install step (success) 11:59:05 INFO - [mozharness: 2017-06-04 18:59:05.848370Z] Running setup-mitmproxy step. 11:59:05 INFO - Running pre-action listener: _resource_record_pre_action 11:59:05 INFO - Running main action method: setup_mitmproxy 11:59:05 INFO - Skipping: mitmproxy is not required 11:59:05 INFO - Running post-action listener: _resource_record_post_action 11:59:05 INFO - [mozharness: 2017-06-04 18:59:05.849567Z] Finished setup-mitmproxy step (success) 11:59:05 INFO - [mozharness: 2017-06-04 18:59:05.849788Z] Running run-tests step. 11:59:05 INFO - Running pre-action listener: _resource_record_pre_action 11:59:05 INFO - Running main action method: run_tests 11:59:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:59:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:59:05 INFO - Python 2.7.3 11:59:05 INFO - Return code: 0 11:59:05 INFO - grabbing minidump binary from tooltool 11:59: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')]} 11:59:05 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 0x10b3840>, '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 0x10b4740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b4bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:59:05 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 11:59:05 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 11:59:05 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 11:59:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:59:05 INFO - Return code: 0 11:59:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:59:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:59:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:59:05 INFO - ENV: RUST_BACKTRACE is now 1 11:59:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:59:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:59:05 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/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 11:59:05 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/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-039 --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 11:59:05 INFO - Using env: {'DISPLAY': ':0', 11:59:05 INFO - 'HOME': '/home/cltbld', 11:59:05 INFO - 'LANG': 'en_US.UTF-8', 11:59:05 INFO - 'LANGUAGE': 'en_US:en', 11:59:05 INFO - 'LOGNAME': 'cltbld', 11:59:05 INFO - 'MAIL': '/var/mail/cltbld', 11:59:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:59:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:59:05 INFO - 'MOZ_NO_REMOTE': '1', 11:59:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:59:05 INFO - 'NO_EM_RESTART': '1', 11:59:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:59:05 INFO - 'PWD': '/builds/slave/test', 11:59:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:59:05 INFO - 'RUST_BACKTRACE': '1', 11:59:05 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 11:59:05 INFO - 'SHELL': '/bin/bash', 11:59:05 INFO - 'SHLVL': '1', 11:59:05 INFO - 'TERM': 'linux', 11:59:05 INFO - 'TMOUT': '86400', 11:59:05 INFO - 'USER': 'cltbld', 11:59:05 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233', 11:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:59:05 INFO - '_': '/tools/buildbot/bin/python'} 11:59:05 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/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--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 11:59:06 INFO - mozversion application_buildid: 20170604180934 11:59:06 INFO - mozversion application_changeset: 8a3aa1701537ea6b8334f432cd030d260d492fa3 11:59:06 INFO - mozversion application_display_name: Nightly 11:59:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:59:06 INFO - mozversion application_name: Firefox 11:59:06 INFO - mozversion application_remotingname: firefox 11:59:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 11:59:06 INFO - mozversion application_vendor: Mozilla 11:59:06 INFO - mozversion application_version: 55.0a1 11:59:06 INFO - mozversion platform_buildid: 20170604180934 11:59:06 INFO - mozversion platform_changeset: 8a3aa1701537ea6b8334f432cd030d260d492fa3 11:59:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 11:59:06 INFO - mozversion platform_version: 55.0a1 11:59:06 INFO - using testdate: 1496602746 11:59:06 INFO - actual date: 1496602746 11:59:06 INFO - starting webserver on 'localhost:38986' 11:59:06 INFO - SUITE-START | Running 2 tests 11:59:06 INFO - TEST-START | dromaeo_css 11:59:06 INFO - operating with platform_type : linux_ 11:59:06 INFO - Initialising browser for dromaeo_css test... 11:59:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38986/getInfo.html -profile /tmp/tmpQyhAes/profile 11:59:06 INFO - TEST-INFO | started process 3301 (/builds/slave/test/build/application/firefox/firefox http://localhost:38986/getInfo.html) 11:59:44 INFO - TEST-INFO | 3301: killed by SIGTERM 11:59:45 INFO - Browser initialized. 11:59:45 INFO - Running cycle 1/1 for dromaeo_css test... 11:59:45 INFO - TEST-INFO | started process 3529 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQyhAes/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:59:56 INFO - PID 3529 | RSS: Main: 192294912 11:59:56 INFO - PID 3529 | 12:02:57 INFO - PID 3529 | Cycle 1(1): loaded http://localhost:38986/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38986/tests/dromaeo/cssquery-ext.html) 12:02:59 INFO - PID 3529 | RSS: Main: 186744832 12:02:59 INFO - PID 3529 | 12:06:01 INFO - PID 3529 | Cycle 1(1): loaded http://localhost:38986/tests/dromaeo/cssquery-ext.html (next: http://localhost:38986/tests/dromaeo/cssquery-jquery.html) 12:06:01 INFO - PID 3529 | RSS: Main: 192835584 12:06:01 INFO - PID 3529 | 12:09:03 INFO - PID 3529 | Cycle 1(1): loaded http://localhost:38986/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38986/tests/dromaeo/cssquery-mootools.html) 12:09:04 INFO - PID 3529 | RSS: Main: 189300736 12:09:04 INFO - PID 3529 | 12:12:06 INFO - PID 3529 | Cycle 1(1): loaded http://localhost:38986/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38986/tests/dromaeo/cssquery-prototype.html) 12:12:06 INFO - PID 3529 | RSS: Main: 193847296 12:12:06 INFO - PID 3529 | 12:15:09 INFO - PID 3529 | Cycle 1(1): loaded http://localhost:38986/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38986/tests/dromaeo/cssquery-yui.html) 12:15:10 INFO - PID 3529 | RSS: Main: 192819200 12:15:10 INFO - PID 3529 | 12:18:12 INFO - PID 3529 | Cycle 1(1): loaded http://localhost:38986/tests/dromaeo/cssquery-yui.html (next: http://localhost:38986/tests/dromaeo/cssquery-dojo.html) 12:18:12 INFO - PID 3529 | RSS: Main: 194121728 12:18:12 INFO - PID 3529 | 12:18:12 INFO - PID 3529 | __start_tp_report 12:18:12 INFO - PID 3529 | _x_x_mozilla_page_load 12:18:12 INFO - PID 3529 | _x_x_mozilla_page_load_details 12:18:12 INFO - PID 3529 | |i|pagename|runs| 12:18:12 INFO - PID 3529 | |0;dojo.html;3082.137001639541;3109.7978631388974;3130.4834702274125;3155.5582218489417;3160.920976975576;5892.705364731768;6003.519718422521;6010.699465026748;6022.187004754357;6043.942310095732;6024.9698751506185;6028.4574388305045;6033.487153591939;6038.245219347582;6042.939570604292;5486.451354864502;5570.693611851347;5579.079451890433;5589.105743081108;5617.157426386055;5482.890342193154;5645.661260324373;5647.943520564803;5650.971745141289;5715.257016587859;5592.916106258409;5682.119271512922;5685.886282274352;5730.9426905730825;5739.454751798572;5484.670919744788;5551.694656793875;5554.2779438673115;5571.108622620402;5599.244102046212;5575.247341608912;5604.775808967636;5614.775408983635;5623.072193088176;5626.409227031144;6019.638821670714;6021.157038014638;6032.336442991267;6056.394360563909;6065.636061836304;6245.875082498324;6434.935650643527;6510.967445162792;6523.608583485006;6544.083828264047;6420.711068001951;6474.320196379406;6549;6571.638559879205;6588.209414870198;6082.361352058058;6088.786892458743;6093.025115981422;6098.939010609926;6117.480014198798;6651.966740166268;6739.191297044288;6742.224644165885;6748.257691653914;6770.052192693027;6155.753769849156;6231.813045608639;6286.559940804192;6366.554341196164;6392.456641185551;6502.869942601122;6514.902276465857;6517.674116294166;6530.673466326664;6543.378379053982;6394.104825324458;6456;6468.450181734511;6468.708908099147;6515.055316979012;6289.119523266746;6355.841103972438;6364.331745166784;6502.252240992252;6506.512011599054;5234.581233501311;5258.6581872178185;5268.341457317835;5270.314859068297;5280.709560974106;4497.77511124449;4501.617362524156;4509.210888094636;4572.954270457253;4597.195490789099;5543.7782488700805;5592.273004509388;5687.772489100473;5689.7724091036725;5696.914546281809;6343.9365606343345;6523.543351965317;6531.118299029666;6536.869262614721;6555.311692272243;5630.8029218977135;5640.858978525488;5648.830535083954;5649.237352957381;5657.462541058593;5677.1768093627015;5681.829545113653;5688.800891968761;5698.886022279531;5701.144828275792;6171.7531298748445;6216.658083805343;6237.282712488031;6319.557630965972;6347.111404403295;6533.379328963741;6536.705848236936;6559.836004099936;6562.901556476561;6566.507511936528;6194.225721784777;6198.287196972406;6259.843503912439;6272.153259310117;6335.619862808247;6328.810135695937;6330.683465826598;6339.873202535831;6352.745890164341;6366.713497892699;6511;6511.73953041873;6522.902156467751;6533.118029066015;6540.117084193573;6145.784897528565;6330.082138090043;6330.39861213184;6335.239771227482;6349.650769207553;6205.937940620536;6278.372162783868;6330.303666596578;6338;6377.2984971654005;6201.3178550358525;6242.531810114168;6278.46633036197;6283.842903927439;6293.40212679813;6433.774817881352;6436.613803171825;6440.6135631862235;6444.258910225197;6447.742090316335;6053.152558641882;6105.145279660762;6137.285055221685;6214.751409943552;6241.188645476241 12:18:12 INFO - PID 3529 | |1;ext.html;714.2143641993804;766.4098644044086;790.0558832195527;1092.2136062035336;1097.9341239525634;34883.65116348836;34896.82551587241;34986.475202871916;35030.47454288188;35130.82434587827;36710.8164459178;37055.629443705555;37101.25797484049;37179.62820371802;37197.62802371976;7089.929100708979;7136.75021374252;7201.819954501127;7237.312455316736;7372.815679607999;7151.427885769126;7236.71053157873;7252.601106939116;7261.2012678605315;7265.4550908681795;7198.496105272633;7211.423086153095;7270.27297270274;7280.762270414042;7294.598797066159;7234.385077268412;7238;7261.491695581285;7264.636768161571;7270.163931147933;7131.393831524327;7132.786016419515;7175.174854891702;7183.784486465414;7193.712251509934;34342.82828585866;34531.482027769605;34563.13592160216;34624.826875865714;34696.479552806726;3392.6098498672477;3457.792532448061;3470.722342212617;3472.8263586820813;3487.0410637074756;27706.445871082466;27785.72214277872;27810.3047423814;27818.165455036382;27877.442451151066;3617.5116359291687;3628.818559072036;3638.3632864248652;3642.817859107034;3648.927021459556;139862;142009.28995355061;155608;166635;167294.16352918278;42610.78694606507;42646.78676606597;42778.35832462516;42892.78553607212;42925.570744292156;45049;45213.32180017302;45379;47870.5212947873;48523.5147648526;12943.352832358345;13040.087193896336;13046.739065218642;13055;13255.536056237985;10485.790284194274;10492.790144197073;10504.73738156537;10542.42016689074;10573.365598064142;13654.249016304;13689.931550342184;13694.315284235749;13770.449182032808;13899.930500347433;5452.372977107604;5509.724513774296;5531.3362396512675;5565.415631358649;5593.161025846156;960.313375936195;961.9759506012406;968.9321747477609;973.7030205787303;991.3407583956732;21827.015355086536;21962.89018554897;22486.212982545534;23246;23325.76674233236;1035.7255327338262;1042.6611351310855;1056.572088304238;1101.6860194844592;1105.3478447715725;11614.593489228006;11753.823692644617;12374.938125309496;12381.75236495265;12392.62822115338;212500;212722;213069;214367;214624;47181;47224.5277547227;47243.5275647246;47269.527304726515;47273.763631182315;1391.589481103077;1413.4134334251376;1422.1680317014454;1439.8344190418236;1444.5810714892773;21081;21844.781552184275;23371.766282336957;23443.648345275175;23746.168884088973;34533.82733086318;42776.358354624084;43903.78048109739;44223.557764421945;44248.11503769971;184905;185583;185924;186385;186389;31598.842005789826;32965;33631.327373452885;33668;33668.66331336655;39606.603933960294;40256.79871600623;40535;40788.79605601953;40864.38703419392;27835.721642783312;29277;29850.910436269252;30726.539101913044;31530.527042094847;29811.552826707182;29853.850730746206;29891;30105;31577.21056973594;33584.32831343408;33659.831700841336;33719.15702107467;34510.30979380449;34710.9586712399;29538.750737418435;29620.111396658136;29681.70318296876;30097.24756881008;30442.543361850032;21686.566268674855;23725.762742372357;23967.28098157058;24414.389640258425;24497.142600008916 12:18:12 INFO - PID 3529 | |2;jquery.html;418.2492426095159;419.76197695573086;430.410337837163;430.4554738256107;435.23181584503345;14442.927785361058;14737.557873263793;19607;20010.799892001058;20111.899440502795;20751.68872466914;21499.355019349405;21644.458888527795;21698.132074717032;21702.674459883114;5805.854853628651;5934.703264836762;5962.821115366546;5971.4327138921735;5996.310424301196;5835.912461313083;5899.764009439617;5919.1713160157615;5927.940720592804;5940.821775346746;5669;5858.2677165354335;5863.882722345572;5894.410558944092;5908.704564771766;5814.215080964079;5853.619514731528;5866.266716660418;5869.090291004901;5874.148248503964;5245.160774276097;5269.394019687747;5272.31459910213;5281.181416880389;5294.020606187868;23947.281581552583;24164;24193.758062419325;24224.636630450557;24309.756902430927;1900.9904950475297;1945.4455480188078;1954.4234450837037;1955.2081407030175;1963.6269108869412;15616.453424130215;16320.183990800531;16374.099424531645;16468.341266349333;16509.422170223985;2169.8372622053407;2203.5923354179527;2241.7758224177614;2243.0354947372625;2253.5943530164564;114908;119454.27640130302;120240.39879800632;120463;120476;10970.396628185526;11421.657350279505;11422;11427.314361138358;11953.223040502513;16129.354825807071;16202.918985405233;16218.351265949466;16256.918715406584;16306.75539866903;8713.259372953244;8910.019897811235;8998.59506322217;9008.774780630405;9065.864012039825;8642.913570864337;8760.386772925835;8763.69327073562;8815.603297851612;8820;7314;7385.778426647209;7450.478466507401;7461.962690186514;7494.288042635941;2092.989535052315;2095.434232757147;2108.2515706923823;2117.8199853012356;2188.6388745857075;937.4422218779815;969.1665167955553;970.9263148575402;983.9803203935882;991.3902949686036;17733.11334433273;17977.910110449364;18271.36050238235;18484;19067;979.8334283171736;983.9803203935882;994.5773046455228;1030.9432981186108;1035.063267742694;10189.694309170736;11561.595344162914;12889.806652900214;13115.672108197181;13181.472741090442;447134;447648;448015;455739;457384;101141.49429252806;105209.47395263128;105397;105520;105857;1188.7087663522493;1196.1328037173155;1220.8962238209851;1234.7530493901256;1238.207547169812;17070.658586828442;17289.576130994086;18386.540336491697;19151.616967660848;19426.4172074838;46756.766216168704;47393.28910066283;48533.5146648529;48542.271865921335;49026.264606031655;62733;62865.37134628595;63267.683661581395;63398;64158.35841641524;9619.086186812241;9710.514474276399;9713;9737.07497787709;9746.9025309746;15262.236888155327;15779.28993195286;15814.446494372642;15869.365225390855;15881.602959925633;13292.268925209206;13479.258640774851;13859.79210311826;14015.229162396166;14067.366968486647;12185.695357615776;12499;12637.68405789826;12781.29702866314;12800.551980680631;13836.861631383557;13884.375203116086;14674.119552826865;14844.332005059583;14847.109173449628;9762.267829912927;9829.606815727577;9841.360311579725;9880;9976.102150806462;13181.670458238621;13276.800847987095;13326.400311986177;13353.53262635803;13373.264470454218 12:18:12 INFO - PID 3529 | |3;mootools.html;1254.1158483269296;1317.3084130831307;1317.7628026955144;1318.1695531814955;1324.3245944568266;10909.290896091748;11406.828897566533;11408.828867566983;11446.427678616057;11689.59086431975;11279.661610151708;11379.089672826174;11453;11457.541698332057;11465.19743617945;2397.184957114581;2425.890834912433;2438.4635380216323;2439.8414103083333;2450.191436825852;2334.871582062986;2350.3536527455003;2357.6581395697613;2358.151065616377;2370.146747171017;2209.8784566848817;2229.1194977983687;2231.2079211879714;2238.820894328458;2245.5621153875;2300.930972070824;2310.792028717415;2316.872572008539;2320.153144102407;2323.233333000106;2119.1205649655376;2122.80894719476;2131.3286314810784;2244.494988627562;2328;10807.83788243177;10881.673549793519;10881.727956801064;10885.673429797118;10913.072388846958;6137.96931015342;6371.936280637181;6374.490040796725;6380.425761681471;6385.904211436832;3936.389859571771;4040.333344998101;4087.9386809197886;4100.876973690794;4127.318992366256;1323.9801402978962;1326.7545504081775;1327.5353626230838;1368.8699573540498;1372.9176249424966;16237.269322880498;16369.754453683205;16462.259198336105;16463.094529800856;16973.57566060846;5295.205719142159;5309.814156504503;5446.700431476228;5476.479734425223;5485.835424937259;12444.191127576678;12446;12531.310777907303;12586.496540138292;12591.874081259253;5965.671888046112;6056.273247210363;6081.391860813883;6094.17174847544;6106.542009349317;5567.749451274703;5660.745266463019;5686.488216060492;5723.055695810228;5780.682062486603;4157.608561696155;4171.290880550314;4173.455821346121;4240.1731662326165;4240.321548552217;1202.6271855724578;1228.8341073954903;1235.32057368447;1247.9064070194772;1257.7673130470891;834.7579202031465;861.5390765940192;872.7556284240422;880.7445840706251;903.9548022598975;6028.156058151862;6197;6232.189815323979;6360.459360954371;6428.871422571522;621.2638023941644;631.623061725443;631.7094136697079;639.4532674563275;643.6427782580713;4205.3902184183125;4518.819247230074;4624.1445332613575;4627.976860115745;4685.390899183084;14083.507077252247;14626.780598291034;14695.77956330656;14708;14711.92644036773;13789.379477923518;14197;14460.85539144616;14468.638284042983;14510.1293922365;7898.60506974649;8651.567421628893;8809.647614095364;8842.823143537093;8859.557022148867;5742.684152371659;6765.864682706417;6894;6962.677091352627;6977.7208911642965;12709.618711438672;13193.274369909363;13391.464341426234;13643.795343069663;13733.587992360246;12997.415116319598;13065;13125.60623181306;13205.801912971505;13213.933930330288;9148.176664100263;9483.857742133736;9948.403095814274;9951.850722239316;10009.849852252077;10990.835137473105;11156.609518666808;11169.832452513381;11173.441327933733;11183.440827958731;8873.157050080232;9009.774755630899;9019.188273055457;9099.454032758056;9125.361224714206;8798.208161265517;8896.911030889609;8979.640814367353;9160.496172710566;9319.30105242096;7742.148363680103;7945.960270198612;7957.283844454027;8006.279434850891;8029.678812847421;5330.573554115739;5642.633228840113;5745.712714364348;5780.335261444988;5868.178455016387;5957.523398128226;6013.63918164894;6172.135900973777;6190.288116866618;6193.721282542387 12:18:12 INFO - PID 3529 | |4;prototype.html;390.2039838728993;408.165301957497;414.19645886979237;414.2378024435039;417.4802371048046;5923;6005.819825405245;6188.133661287423;6303.590266632666;6325.493960483162;5990.89168503826;6136.171616831726;6159.10692949522;6162.691865406723;6183.443490085891;4985.900281994358;4989.176785830334;4990.850274491771;5001.599872010231;5005.299258103868;5016.27264046713;5019.196928491442;5023.874403139914;5040.243963405482;5045.445001049881;5000.799968001275;5001.524855138756;5015.720991147271;5016.297718319438;5029;5039.496050394968;5045.091883460976;5054.545090941796;5056.306137443942;5062.31658726071;4540.659450541222;4544.750038747868;4545.181867263891;4552.339910712928;4552.453705555321;5959.318306761975;6055.152278680988;6080.574359794816;6082.635041897456;6088.838462345848;5703.686297253649;5715;5715.971420142914;5733.8566535836935;5736.627119237236;6562.60624362535;6568.770093046721;6572.5399222054475;6582.440492558138;6596.295518837302;4910.975445122752;4913.606911447076;4922.163232250526;4922.187839006559;4922.26166075088;6495.999999999953;6799.796006119825;6823.590584564942;6873.725050997954;6888.931110688879;4634.652401069933;4637.675362724577;4641.2109941310055;4665.2302370108555;4691.1555919934735;4696.929546056812;4713.787879545429;4718;4725.480197178307;4734.881627959328;5421.512063914267;5424.783008679688;5437.809676661298;5445.237666726662;5454.290942177571;6296.622202667763;6449.709763060673;6460.257070436866;6470.741170353133;6502.154719886385;1598.5364244369234;1635.9100249486155;1637.3450619752196;1638.7951506061743;1638.942637007699;1054.6572363981736;1076.1014552848303;1099.5821587796586;1101.3336931156696;1101.3391964821203;5726.3700992890745;5732.426757324234;5738.713064346766;5746.02317606008;5757.280339957505;6666.699998500079;6678.599284042973;6702.530822842452;6704;6718.428933540704;5661.46216109469;5665.49010589049;5706.942930570641;5710.942890571124;5720.3707592165665;3583.4266517357096;3583.498310236569;3583.8924832255075;3590.1383667919513;3600.4419315005694;6477.352264773485;6510.934890651033;6513.772017979348;6543.770968016097;6543.836404089936;6726.192856857208;6789.932100679029;6846.281140480178;6854.485913556503;6871.553349032297;6217.823761683556;6417.582857114273;6458.967705161538;6480.935190648033;6515.4787616990525;6677.799666010027;6717.932820671731;6764.492663050192;6771.119754431892;6804.4556435484055;6674.632895190811;6697.497687673542;6707.195136583641;6725.5628384156835;6742.808587209079;6321.652309123042;6513.381228783258;6539.6403197824575;6571.5399922005;6576.868462630816;4593.379893714306;4597.747123908083;4609.423822022247;4612.86161415158;4623.237165867594;6764.8499755040775;6765.308672831792;6767.424768894699;6786.253512113565;6825.590464572141;6509.479241660751;6550.213974323112;6582.827666870017;6607.537472376887;6618.900716489353;6546.18172728409;6560.212774467094;6562.671866406565;6595.307492713196;6612.768553100618;6513.706883190173;6522.934770652233;6526.738930442919;6554.918438457601;6562.639054852029;6584.242812076481;6616.603003819786;6622.569532980341;6634.9004764927595;6645.435138013323;6390.33851198701;6404.519661025349;6434.4852411806005;6447.742090316522;6453.45145662624 12:18:12 INFO - PID 3529 | |5;yui.html;797.7407342613652;810.3436216664505;823.3495538524564;826.7974346285162;841.983160336793;16876.240569174384;17266.568335791613;17330.913345433288;18953.33663321784;20592;18616.25534978599;18653.347132850355;18687.159077841497;18894.338698145566;18925.337613183543;907.469130558624;910.0489987962562;914.1635403605693;916.6104405627615;930.3812964378681;903.8870141232346;968.0174622757906;974.5468357213894;976.6142373762359;978.5792109392994;1047.0942634621035;1049.5014867937746;1054.3146954479573;1054.3305001324177;1060.7295139739394;1020.4285600063914;1024.6772266735954;1030.294248439821;1032.4837581209395;1035.2390992620456;752.8381397999457;756.3797685897566;757.7385801898337;758.6586036283694;758.8482303539259;16754.4135955241;16976.320582878034;17399;17527;17579.912100439546;18061.548461288443;18181.36365227224;18308.359207427675;18406.44780656569;18631;14554;14843.92578037103;14856.554303370916;14886.478973235993;14913.105213687106;3337.215754297738;3360.9663903360897;3363.1760218746317;3370.96629033709;3459.3254315408503;88145.11854881434;89277.55361223282;89485;89645.55177224138;90502.09497905003;14332.355044023045;14466.27668616565;14546.272686365639;14665.120092794466;15044;25879;26579.867100664374;26678.333041674112;26712.732872671415;26809.329766755596;7905.723299684483;7914.881276780853;8236.876446853303;8304.086550479442;8358.205970432798;3896.5324161100284;4007.539132999684;4024.3963405488826;4038.374052021941;4038.6163314485666;4070.8575199868455;4189.49726032878;4204.285271503852;4241.088166044316;4419.337099435111;836.0761358698551;849.8512760266929;857.0743596915316;858.6908712863365;866.2117473099449;651.9087327774115;673.1619134177882;696.5368030259922;703.4021082080293;703.802935178151;10564.471776411148;11389.715257118638;11978.940105299593;12165.93917030427;12487.687807804696;667.5494041521953;682.8566001139816;687.556526040701;691.934266244716;706.321930946287;4771.427428708508;4941.283513890466;5122.564582010496;5160.587153027749;5164.147915593885;81316.59341703371;81774.59112704398;83605;84072.57963710143;86359;67585.32414675888;68827.65586172037;68971.65514172397;69085.3091469079;69279.65360173267;62324.68837655873;63612.36387636157;63691.36308636947;64929.35070649328;65656.67171664111;10482.895171048192;10831.512581933674;11395.373254471084;11460.770784584429;12182.75634487323;28028.71971280261;28560.42879142364;29010;29031.7096829029;29382.11853644394;54002;54089.45910541002;54308.728456359044;54503.18245226245;56916;14749.778753318924;14794.482193123189;14899.137607799024;15045.172515511751;15128.092314461168;18448;18939.810601894354;19309.710354344414;19646.312379066665;20076.09657565384;17023.404180854108;17692.99219132776;17965.461036168937;18038.09809509493;18186.45440636783;16698.037774456057;17351.045692487034;17396.39112631052;17453.127343633023;17684.204210810803;15923.681526369175;16057.75913361324;16107.597310067342;16277.593060173116;16359.67280654404;10260.281780275309;11650.184487086162;12256.938715306367;12395.008399327851;12524.561640342909;12209.938950305546;12627.87372126267;12976;12985.935070324587;13013.804792928304 12:18:12 INFO - PID 3529 | __end_tp_report 12:18:12 INFO - PID 3529 | __start_cc_report 12:18:12 INFO - PID 3529 | _x_x_mozilla_cycle_collect,406 12:18:12 INFO - PID 3529 | __end_cc_report 12:18:12 INFO - PID 3529 | __startTimestamp1496603892492__endTimestamp 12:18:12 INFO - PID 3529 | 12:18:12 INFO - PID 3529 | ------- Summary: start ------- 12:18:12 INFO - PID 3529 | Number of tests: 6 12:18:12 INFO - PID 3529 | 12:18:12 INFO - PID 3529 | [#0] dojo.html Cycles:165 Average:5980.90 Median:6198.29 stddev:685.88 (11.1%) stddev-sans-first:649.20 12:18:12 INFO - PID 3529 | Values: 3082.1 3109.8 3130.5 3155.6 3160.9 5892.7 6003.5 6010.7 6022.2 6043.9 6025.0 6028.5 6033.5 6038.2 6042.9 5486.5 5570.7 5579.1 5589.1 5617.2 5482.9 5645.7 5647.9 5651.0 5715.3 5592.9 5682.1 5685.9 5730.9 5739.5 5484.7 5551.7 5554.3 5571.1 5599.2 5575.2 5604.8 5614.8 5623.1 5626.4 6019.6 6021.2 6032.3 6056.4 6065.6 6245.9 6434.9 6511.0 6523.6 6544.1 6420.7 6474.3 6549.0 6571.6 6588.2 6082.4 6088.8 6093.0 6098.9 6117.5 6652.0 6739.2 6742.2 6748.3 6770.1 6155.8 6231.8 6286.6 6366.6 6392.5 6502.9 6514.9 6517.7 6530.7 6543.4 6394.1 6456.0 6468.5 6468.7 6515.1 6289.1 6355.8 6364.3 6502.3 6506.5 5234.6 5258.7 5268.3 5270.3 5280.7 4497.8 4501.6 4509.2 4573.0 4597.2 5543.8 5592.3 5687.8 5689.8 5696.9 6343.9 6523.5 6531.1 6536.9 6555.3 5630.8 5640.9 5648.8 5649.2 5657.5 5677.2 5681.8 5688.8 5698.9 5701.1 6171.8 6216.7 6237.3 6319.6 6347.1 6533.4 6536.7 6559.8 6562.9 6566.5 6194.2 6198.3 6259.8 6272.2 6335.6 6328.8 6330.7 6339.9 6352.7 6366.7 6511.0 6511.7 6522.9 6533.1 6540.1 6145.8 6330.1 6330.4 6335.2 6349.7 6205.9 6278.4 6330.3 6338.0 6377.3 6201.3 6242.5 6278.5 6283.8 6293.4 6433.8 6436.6 6440.6 6444.3 6447.7 6053.2 6105.1 6137.3 6214.8 6241.2 12:18:12 INFO - PID 3529 | 12:18:12 INFO - PID 3529 | [#1] ext.html Cycles:180 Average:34313.34 Median:18867.72 stddev:48242.78 (255.7%) stddev-sans-first:48312.14 12:18:12 INFO - PID 3529 | Values: 714.2 766.4 790.1 1092.2 1097.9 34883.7 34896.8 34986.5 35030.5 35130.8 36710.8 37055.6 37101.3 37179.6 37197.6 7089.9 7136.8 7201.8 7237.3 7372.8 7151.4 7236.7 7252.6 7261.2 7265.5 7198.5 7211.4 7270.3 7280.8 7294.6 7234.4 7238.0 7261.5 7264.6 7270.2 7131.4 7132.8 7175.2 7183.8 7193.7 34342.8 34531.5 34563.1 34624.8 34696.5 3392.6 3457.8 3470.7 3472.8 3487.0 27706.4 27785.7 27810.3 27818.2 27877.4 3617.5 3628.8 3638.4 3642.8 3648.9 139862.0 142009.3 155608.0 166635.0 167294.2 42610.8 42646.8 42778.4 42892.8 42925.6 45049.0 45213.3 45379.0 47870.5 48523.5 12943.4 13040.1 13046.7 13055.0 13255.5 10485.8 10492.8 10504.7 10542.4 10573.4 13654.2 13689.9 13694.3 13770.4 13899.9 5452.4 5509.7 5531.3 5565.4 5593.2 960.3 962.0 968.9 973.7 991.3 21827.0 21962.9 22486.2 23246.0 23325.8 1035.7 1042.7 1056.6 1101.7 1105.3 11614.6 11753.8 12374.9 12381.8 12392.6 212500.0 212722.0 213069.0 214367.0 214624.0 47181.0 47224.5 47243.5 47269.5 47273.8 1391.6 1413.4 1422.2 1439.8 1444.6 21081.0 21844.8 23371.8 23443.6 23746.2 34533.8 42776.4 43903.8 44223.6 44248.1 184905.0 185583.0 185924.0 186385.0 186389.0 31598.8 32965.0 33631.3 33668.0 33668.7 39606.6 40256.8 40535.0 40788.8 40864.4 27835.7 29277.0 29850.9 30726.5 31530.5 29811.6 29853.9 29891.0 30105.0 31577.2 33584.3 33659.8 33719.2 34510.3 34711.0 29538.8 29620.1 29681.7 30097.2 30442.5 21686.6 23725.8 23967.3 24414.4 24497.1 12:18:12 INFO - PID 3529 | 12:18:12 INFO - PID 3529 | [#2] jquery.html Cycles:180 Average:30430.55 Median:21700.40 stddev:75877.98 (349.7%) stddev-sans-first:76057.37 12:18:12 INFO - PID 3529 | Values: 418.2 419.8 430.4 430.5 435.2 14442.9 14737.6 19607.0 20010.8 20111.9 20751.7 21499.4 21644.5 21698.1 21702.7 5805.9 5934.7 5962.8 5971.4 5996.3 5835.9 5899.8 5919.2 5927.9 5940.8 5669.0 5858.3 5863.9 5894.4 5908.7 5814.2 5853.6 5866.3 5869.1 5874.1 5245.2 5269.4 5272.3 5281.2 5294.0 23947.3 24164.0 24193.8 24224.6 24309.8 1901.0 1945.4 1954.4 1955.2 1963.6 15616.5 16320.2 16374.1 16468.3 16509.4 2169.8 2203.6 2241.8 2243.0 2253.6 114908.0 119454.3 120240.4 120463.0 120476.0 10970.4 11421.7 11422.0 11427.3 11953.2 16129.4 16202.9 16218.4 16256.9 16306.8 8713.3 8910.0 8998.6 9008.8 9065.9 8642.9 8760.4 8763.7 8815.6 8820.0 7314.0 7385.8 7450.5 7462.0 7494.3 2093.0 2095.4 2108.3 2117.8 2188.6 937.4 969.2 970.9 984.0 991.4 17733.1 17977.9 18271.4 18484.0 19067.0 979.8 984.0 994.6 1030.9 1035.1 10189.7 11561.6 12889.8 13115.7 13181.5 447134.0 447648.0 448015.0 455739.0 457384.0 101141.5 105209.5 105397.0 105520.0 105857.0 1188.7 1196.1 1220.9 1234.8 1238.2 17070.7 17289.6 18386.5 19151.6 19426.4 46756.8 47393.3 48533.5 48542.3 49026.3 62733.0 62865.4 63267.7 63398.0 64158.4 9619.1 9710.5 9713.0 9737.1 9746.9 15262.2 15779.3 15814.4 15869.4 15881.6 13292.3 13479.3 13859.8 14015.2 14067.4 12185.7 12499.0 12637.7 12781.3 12800.6 13836.9 13884.4 14674.1 14844.3 14847.1 9762.3 9829.6 9841.4 9880.0 9976.1 13181.7 13276.8 13326.4 13353.5 13373.3 12:18:12 INFO - PID 3529 | 12:18:12 INFO - PID 3529 | [#3] mootools.html Cycles:180 Average:6980.52 Median:3193.29 stddev:4474.91 (140.1%) stddev-sans-first:4466.77 12:18:12 INFO - PID 3529 | Values: 1254.1 1317.3 1317.8 1318.2 1324.3 10909.3 11406.8 11408.8 11446.4 11689.6 11279.7 11379.1 11453.0 11457.5 11465.2 2397.2 2425.9 2438.5 2439.8 2450.2 2334.9 2350.4 2357.7 2358.2 2370.1 2209.9 2229.1 2231.2 2238.8 2245.6 2300.9 2310.8 2316.9 2320.2 2323.2 2119.1 2122.8 2131.3 2244.5 2328.0 10807.8 10881.7 10881.7 10885.7 10913.1 6138.0 6371.9 6374.5 6380.4 6385.9 3936.4 4040.3 4087.9 4100.9 4127.3 1324.0 1326.8 1327.5 1368.9 1372.9 16237.3 16369.8 16462.3 16463.1 16973.6 5295.2 5309.8 5446.7 5476.5 5485.8 12444.2 12446.0 12531.3 12586.5 12591.9 5965.7 6056.3 6081.4 6094.2 6106.5 5567.7 5660.7 5686.5 5723.1 5780.7 4157.6 4171.3 4173.5 4240.2 4240.3 1202.6 1228.8 1235.3 1247.9 1257.8 834.8 861.5 872.8 880.7 904.0 6028.2 6197.0 6232.2 6360.5 6428.9 621.3 631.6 631.7 639.5 643.6 4205.4 4518.8 4624.1 4628.0 4685.4 14083.5 14626.8 14695.8 14708.0 14711.9 13789.4 14197.0 14460.9 14468.6 14510.1 7898.6 8651.6 8809.6 8842.8 8859.6 5742.7 6765.9 6894.0 6962.7 6977.7 12709.6 13193.3 13391.5 13643.8 13733.6 12997.4 13065.0 13125.6 13205.8 13213.9 9148.2 9483.9 9948.4 9951.9 10009.8 10990.8 11156.6 11169.8 11173.4 11183.4 8873.2 9009.8 9019.2 9099.5 9125.4 8798.2 8896.9 8979.6 9160.5 9319.3 7742.1 7946.0 7957.3 8006.3 8029.7 5330.6 5642.6 5745.7 5780.3 5868.2 5957.5 6013.6 6172.1 6190.3 6193.7 12:18:12 INFO - PID 3529 | 12:18:12 INFO - PID 3529 | [#4] prototype.html Cycles:180 Average:5468.83 Median:6081.60 stddev:1581.27 (26.0%) stddev-sans-first:1539.08 12:18:12 INFO - PID 3529 | Values: 390.2 408.2 414.2 414.2 417.5 5923.0 6005.8 6188.1 6303.6 6325.5 5990.9 6136.2 6159.1 6162.7 6183.4 4985.9 4989.2 4990.9 5001.6 5005.3 5016.3 5019.2 5023.9 5040.2 5045.4 5000.8 5001.5 5015.7 5016.3 5029.0 5039.5 5045.1 5054.5 5056.3 5062.3 4540.7 4544.8 4545.2 4552.3 4552.5 5959.3 6055.2 6080.6 6082.6 6088.8 5703.7 5715.0 5716.0 5733.9 5736.6 6562.6 6568.8 6572.5 6582.4 6596.3 4911.0 4913.6 4922.2 4922.2 4922.3 6496.0 6799.8 6823.6 6873.7 6888.9 4634.7 4637.7 4641.2 4665.2 4691.2 4696.9 4713.8 4718.0 4725.5 4734.9 5421.5 5424.8 5437.8 5445.2 5454.3 6296.6 6449.7 6460.3 6470.7 6502.2 1598.5 1635.9 1637.3 1638.8 1638.9 1054.7 1076.1 1099.6 1101.3 1101.3 5726.4 5732.4 5738.7 5746.0 5757.3 6666.7 6678.6 6702.5 6704.0 6718.4 5661.5 5665.5 5706.9 5710.9 5720.4 3583.4 3583.5 3583.9 3590.1 3600.4 6477.4 6510.9 6513.8 6543.8 6543.8 6726.2 6789.9 6846.3 6854.5 6871.6 6217.8 6417.6 6459.0 6480.9 6515.5 6677.8 6717.9 6764.5 6771.1 6804.5 6674.6 6697.5 6707.2 6725.6 6742.8 6321.7 6513.4 6539.6 6571.5 6576.9 4593.4 4597.7 4609.4 4612.9 4623.2 6764.8 6765.3 6767.4 6786.3 6825.6 6509.5 6550.2 6582.8 6607.5 6618.9 6546.2 6560.2 6562.7 6595.3 6612.8 6513.7 6522.9 6526.7 6554.9 6562.6 6584.2 6616.6 6622.6 6634.9 6645.4 6390.3 6404.5 6434.5 6447.7 6453.5 12:18:12 INFO - PID 3529 | 12:18:12 INFO - PID 3529 | [#5] yui.html Cycles:180 Average:18978.72 Median:28294.57 stddev:23212.83 (82.0%) stddev-sans-first:23237.80 12:18:12 INFO - PID 3529 | Values: 797.7 810.3 823.3 826.8 842.0 16876.2 17266.6 17330.9 18953.3 20592.0 18616.3 18653.3 18687.2 18894.3 18925.3 907.5 910.0 914.2 916.6 930.4 903.9 968.0 974.5 976.6 978.6 1047.1 1049.5 1054.3 1054.3 1060.7 1020.4 1024.7 1030.3 1032.5 1035.2 752.8 756.4 757.7 758.7 758.8 16754.4 16976.3 17399.0 17527.0 17579.9 18061.5 18181.4 18308.4 18406.4 18631.0 14554.0 14843.9 14856.6 14886.5 14913.1 3337.2 3361.0 3363.2 3371.0 3459.3 88145.1 89277.6 89485.0 89645.6 90502.1 14332.4 14466.3 14546.3 14665.1 15044.0 25879.0 26579.9 26678.3 26712.7 26809.3 7905.7 7914.9 8236.9 8304.1 8358.2 3896.5 4007.5 4024.4 4038.4 4038.6 4070.9 4189.5 4204.3 4241.1 4419.3 836.1 849.9 857.1 858.7 866.2 651.9 673.2 696.5 703.4 703.8 10564.5 11389.7 11978.9 12165.9 12487.7 667.5 682.9 687.6 691.9 706.3 4771.4 4941.3 5122.6 5160.6 5164.1 81316.6 81774.6 83605.0 84072.6 86359.0 67585.3 68827.7 68971.7 69085.3 69279.7 62324.7 63612.4 63691.4 64929.4 65656.7 10482.9 10831.5 11395.4 11460.8 12182.8 28028.7 28560.4 29010.0 29031.7 29382.1 54002.0 54089.5 54308.7 54503.2 56916.0 14749.8 14794.5 14899.1 15045.2 15128.1 18448.0 18939.8 19309.7 19646.3 20076.1 17023.4 17693.0 17965.5 18038.1 18186.5 16698.0 17351.0 17396.4 17453.1 17684.2 15923.7 16057.8 16107.6 16277.6 16359.7 10260.3 11650.2 12256.9 12395.0 12524.6 12209.9 12627.9 12976.0 12985.9 13013.8 12:18:12 INFO - PID 3529 | -------- Summary: end -------- 12:18:12 INFO - PID 3529 | 12:18:13 INFO - TEST-INFO | 3529: exit 0 12:18:13 INFO - TEST-OK | dromaeo_css | took 1147179ms 12:18:13 INFO - TEST-START | kraken 12:18:13 INFO - operating with platform_type : linux_ 12:18:13 INFO - Initialising browser for kraken test... 12:18:13 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38986/getInfo.html -profile /tmp/tmpP4wvRQ/profile 12:18:13 INFO - TEST-INFO | started process 3952 (/builds/slave/test/build/application/firefox/firefox http://localhost:38986/getInfo.html) 12:18:48 INFO - TEST-INFO | 3952: killed by SIGTERM 12:18:48 INFO - Browser initialized. 12:18:48 INFO - Running cycle 1/1 for kraken test... 12:18:48 INFO - TEST-INFO | started process 4181 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpP4wvRQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:19:00 INFO - PID 4181 | RSS: Main: 193048576 12:19:00 INFO - PID 4181 | 12:19:03 INFO - PID 4181 | Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38986/tests/kraken/driver.html?testName=audio-beat-detection) 12:19:04 INFO - PID 4181 | RSS: Main: 196767744 12:19:04 INFO - PID 4181 | 12:19:06 INFO - PID 4181 | Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38986/tests/kraken/driver.html?testName=audio-dft) 12:19:07 INFO - PID 4181 | RSS: Main: 194850816 12:19:07 INFO - PID 4181 | 12:19:10 INFO - PID 4181 | Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38986/tests/kraken/driver.html?testName=audio-fft) 12:19:11 INFO - PID 4181 | RSS: Main: 190545920 12:19:11 INFO - PID 4181 | 12:19:13 INFO - PID 4181 | Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38986/tests/kraken/driver.html?testName=audio-oscillator) 12:19:13 INFO - PID 4181 | RSS: Main: 191119360 12:19:13 INFO - PID 4181 | 12:19:16 INFO - PID 4181 | Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38986/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:19:16 INFO - PID 4181 | RSS: Main: 191004672 12:19:16 INFO - PID 4181 | 12:19:19 INFO - PID 4181 | Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38986/tests/kraken/driver.html?testName=imaging-darkroom) 12:19:20 INFO - PID 4181 | RSS: Main: 191787008 12:19:20 INFO - PID 4181 | 12:19:23 INFO - PID 4181 | Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38986/tests/kraken/driver.html?testName=imaging-desaturate) 12:19:24 INFO - PID 4181 | RSS: Main: 191148032 12:19:24 INFO - PID 4181 | 12:19:27 INFO - PID 4181 | Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38986/tests/kraken/driver.html?testName=json-parse-financial) 12:19:28 INFO - PID 4181 | RSS: Main: 191926272 12:19:28 INFO - PID 4181 | 12:19:29 INFO - PID 4181 | Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38986/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:19:30 INFO - PID 4181 | RSS: Main: 191873024 12:19:30 INFO - PID 4181 | 12:19:32 INFO - PID 4181 | Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38986/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:19:32 INFO - PID 4181 | RSS: Main: 191791104 12:19:32 INFO - PID 4181 | 12:19:34 INFO - PID 4181 | Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38986/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:19:35 INFO - PID 4181 | RSS: Main: 192077824 12:19:35 INFO - PID 4181 | 12:19:38 INFO - PID 4181 | Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38986/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:19:38 INFO - PID 4181 | RSS: Main: 192061440 12:19:38 INFO - PID 4181 | 12:19:42 INFO - PID 4181 | Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38986/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:19:42 INFO - PID 4181 | RSS: Main: 191750144 12:19:42 INFO - PID 4181 | 12:19:44 INFO - PID 4181 | Cycle 1(1): loaded http://localhost:38986/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38986/tests/kraken/driver.html?testName=ai-astar) 12:19:44 INFO - PID 4181 | RSS: Main: 193142784 12:19:44 INFO - PID 4181 | 12:19:44 INFO - PID 4181 | __start_tp_report 12:19:44 INFO - PID 4181 | _x_x_mozilla_page_load 12:19:44 INFO - PID 4181 | _x_x_mozilla_page_load_details 12:19:44 INFO - PID 4181 | |i|pagename|runs| 12:19:44 INFO - PID 4181 | |0;ai-astar;103;110;111;110;113;110;110;111;115;112 12:19:44 INFO - PID 4181 | |1;audio-beat-detection;145;118;120;171;121;120;120;125;142;122 12:19:44 INFO - PID 4181 | |2;audio-dft;164;166;163;164;164;166;167;176;163;162 12:19:44 INFO - PID 4181 | |3;audio-fft;73;73;78;112;74;77;76;75;105;75 12:19:44 INFO - PID 4181 | |4;audio-oscillator;82;84;105;83;83;85;97;82;87;104 12:19:44 INFO - PID 4181 | |5;imaging-gaussian-blur;114;115;113;114;114;114;113;114;115;114 12:19:44 INFO - PID 4181 | |6;imaging-darkroom;150;149;150;151;151;153;150;152;150;155 12:19:44 INFO - PID 4181 | |7;imaging-desaturate;94;95;94;94;94;94;94;94;95;94 12:19:44 INFO - PID 4181 | |8;json-parse-financial;54;58;55;55;57;58;60;57;55;59 12:19:44 INFO - PID 4181 | |9;json-stringify-tinderbox;55;55;55;56;55;55;55;54;59;55 12:19:44 INFO - PID 4181 | |10;stanford-crypto-aes;86;90;85;92;98;87;87;98;105;93 12:19:44 INFO - PID 4181 | |11;stanford-crypto-ccm;132;137;136;140;138;132;132;141;133;133 12:19:44 INFO - PID 4181 | |12;stanford-crypto-pbkdf2;186;192;189;193;197;189;191;188;190;196 12:19:44 INFO - PID 4181 | |13;stanford-crypto-sha256-iterative;72;71;77;74;77;74;71;72;74;71 12:19:44 INFO - PID 4181 | __end_tp_report 12:19:44 INFO - PID 4181 | __start_cc_report 12:19:44 INFO - PID 4181 | _x_x_mozilla_cycle_collect,981 12:19:44 INFO - PID 4181 | __end_cc_report 12:19:44 INFO - PID 4181 | __startTimestamp1496603984782__endTimestamp 12:19:44 INFO - PID 4181 | 12:19:44 INFO - PID 4181 | ------- Summary: start ------- 12:19:44 INFO - PID 4181 | Number of tests: 14 12:19:44 INFO - PID 4181 | 12:19:44 INFO - PID 4181 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:3.10 (2.8%) stddev-sans-first:1.73 12:19:44 INFO - PID 4181 | Values: 103.0 110.0 111.0 110.0 113.0 110.0 110.0 111.0 115.0 112.0 12:19:44 INFO - PID 4181 | 12:19:44 INFO - PID 4181 | [#1] audio-beat-detection Cycles:10 Average:130.40 Median:123.50 stddev:17.20 (13.9%) stddev-sans-first:17.41 12:19:44 INFO - PID 4181 | Values: 145.0 118.0 120.0 171.0 121.0 120.0 120.0 125.0 142.0 122.0 12:19:44 INFO - PID 4181 | 12:19:44 INFO - PID 4181 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.00 stddev:4.01 (2.4%) stddev-sans-first:4.21 12:19:44 INFO - PID 4181 | Values: 164.0 166.0 163.0 164.0 164.0 166.0 167.0 176.0 163.0 162.0 12:19:44 INFO - PID 4181 | 12:19:44 INFO - PID 4181 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.00 stddev:14.26 (19.0%) stddev-sans-first:14.76 12:19:44 INFO - PID 4181 | Values: 73.0 73.0 78.0 112.0 74.0 77.0 76.0 75.0 105.0 75.0 12:19:44 INFO - PID 4181 | 12:19:44 INFO - PID 4181 | [#4] audio-oscillator Cycles:10 Average:89.20 Median:83.50 stddev:9.19 (11.0%) stddev-sans-first:9.37 12:19:44 INFO - PID 4181 | Values: 82.0 84.0 105.0 83.0 83.0 85.0 97.0 82.0 87.0 104.0 12:19:44 INFO - PID 4181 | 12:19:44 INFO - PID 4181 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 12:19:44 INFO - PID 4181 | Values: 114.0 115.0 113.0 114.0 114.0 114.0 113.0 114.0 115.0 114.0 12:19:44 INFO - PID 4181 | 12:19:44 INFO - PID 4181 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:1.79 (1.2%) stddev-sans-first:1.86 12:19:44 INFO - PID 4181 | Values: 150.0 149.0 150.0 151.0 151.0 153.0 150.0 152.0 150.0 155.0 12:19:44 INFO - PID 4181 | 12:19:44 INFO - PID 4181 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:19:44 INFO - PID 4181 | Values: 94.0 95.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 12:19:44 INFO - PID 4181 | 12:19:44 INFO - PID 4181 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.50 stddev:1.99 (3.5%) stddev-sans-first:1.83 12:19:44 INFO - PID 4181 | Values: 54.0 58.0 55.0 55.0 57.0 58.0 60.0 57.0 55.0 59.0 12:19:44 INFO - PID 4181 | 12:19:44 INFO - PID 4181 | [#9] json-stringify-tinderbox Cycles:10 Average:55.40 Median:55.00 stddev:1.35 (2.5%) stddev-sans-first:1.42 12:19:44 INFO - PID 4181 | Values: 55.0 55.0 55.0 56.0 55.0 55.0 55.0 54.0 59.0 55.0 12:19:44 INFO - PID 4181 | 12:19:44 INFO - PID 4181 | [#10] stanford-crypto-aes Cycles:10 Average:92.10 Median:91.00 stddev:6.51 (7.1%) stddev-sans-first:6.51 12:19:44 INFO - PID 4181 | Values: 86.0 90.0 85.0 92.0 98.0 87.0 87.0 98.0 105.0 93.0 12:19:44 INFO - PID 4181 | 12:19:44 INFO - PID 4181 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:136.50 stddev:3.47 (2.5%) stddev-sans-first:3.46 12:19:44 INFO - PID 4181 | Values: 132.0 137.0 136.0 140.0 138.0 132.0 132.0 141.0 133.0 133.0 12:19:44 INFO - PID 4181 | 12:19:44 INFO - PID 4181 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:191.10 Median:191.50 stddev:3.48 (1.8%) stddev-sans-first:3.16 12:19:44 INFO - PID 4181 | Values: 186.0 192.0 189.0 193.0 197.0 189.0 191.0 188.0 190.0 196.0 12:19:44 INFO - PID 4181 | 12:19:44 INFO - PID 4181 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.30 Median:74.00 stddev:2.31 (3.1%) stddev-sans-first:2.40 12:19:44 INFO - PID 4181 | Values: 72.0 71.0 77.0 74.0 77.0 74.0 71.0 72.0 74.0 71.0 12:19:44 INFO - PID 4181 | -------- Summary: end -------- 12:19:44 INFO - PID 4181 | 12:19:45 INFO - TEST-INFO | 4181: exit 0 12:19:46 INFO - TEST-OK | kraken | took 92589ms 12:19:46 INFO - SUITE-END | took 1239s 12:19:46 INFO - Completed test suite (00:20:40) 12:19:46 INFO - javascript benchmark 12:19:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7652.277286283851, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3082.137001639541, 3109.7978631388974, 3130.4834702274125, 3155.5582218489417, 3160.920976975576, 5892.705364731768, 6003.519718422521, 6010.699465026748, 6022.187004754357, 6043.942310095732, 6024.9698751506185, 6028.4574388305045, 6033.487153591939, 6038.245219347582, 6042.939570604292, 5486.451354864502, 5570.693611851347, 5579.079451890433, 5589.105743081108, 5617.157426386055, 5482.890342193154, 5645.661260324373, 5647.943520564803, 5650.971745141289, 5715.257016587859, 5592.916106258409, 5682.119271512922, 5685.886282274352, 5730.9426905730825, 5739.454751798572, 5484.670919744788, 5551.694656793875, 5554.2779438673115, 5571.108622620402, 5599.244102046212, 5575.247341608912, 5604.775808967636, 5614.775408983635, 5623.072193088176, 5626.409227031144, 6019.638821670714, 6021.157038014638, 6032.336442991267, 6056.394360563909, 6065.636061836304, 6245.875082498324, 6434.935650643527, 6510.967445162792, 6523.608583485006, 6544.083828264047, 6420.711068001951, 6474.320196379406, 6549.0, 6571.638559879205, 6588.209414870198, 6082.361352058058, 6088.786892458743, 6093.025115981422, 6098.939010609926, 6117.480014198798, 6651.966740166268, 6739.191297044288, 6742.224644165885, 6748.257691653914, 6770.052192693027, 6155.753769849156, 6231.813045608639, 6286.559940804192, 6366.554341196164, 6392.456641185551, 6502.869942601122, 6514.902276465857, 6517.674116294166, 6530.673466326664, 6543.378379053982, 6394.104825324458, 6456.0, 6468.450181734511, 6468.708908099147, 6515.055316979012, 6289.119523266746, 6355.841103972438, 6364.331745166784, 6502.252240992252, 6506.512011599054, 5234.581233501311, 5258.6581872178185, 5268.341457317835, 5270.314859068297, 5280.709560974106, 4497.77511124449, 4501.617362524156, 4509.210888094636, 4572.954270457253, 4597.195490789099, 5543.7782488700805, 5592.273004509388, 5687.772489100473, 5689.7724091036725, 5696.914546281809, 6343.9365606343345, 6523.543351965317, 6531.118299029666, 6536.869262614721, 6555.311692272243, 5630.8029218977135, 5640.858978525488, 5648.830535083954, 5649.237352957381, 5657.462541058593, 5677.1768093627015, 5681.829545113653, 5688.800891968761, 5698.886022279531, 5701.144828275792, 6171.7531298748445, 6216.658083805343, 6237.282712488031, 6319.557630965972, 6347.111404403295, 6533.379328963741, 6536.705848236936, 6559.836004099936, 6562.901556476561, 6566.507511936528, 6194.225721784777, 6198.287196972406, 6259.843503912439, 6272.153259310117, 6335.619862808247, 6328.810135695937, 6330.683465826598, 6339.873202535831, 6352.745890164341, 6366.713497892699, 6511.0, 6511.73953041873, 6522.902156467751, 6533.118029066015, 6540.117084193573, 6145.784897528565, 6330.082138090043, 6330.39861213184, 6335.239771227482, 6349.650769207553, 6205.937940620536, 6278.372162783868, 6330.303666596578, 6338.0, 6377.2984971654005, 6201.3178550358525, 6242.531810114168, 6278.46633036197, 6283.842903927439, 6293.40212679813, 6433.774817881352, 6436.613803171825, 6440.6135631862235, 6444.258910225197, 6447.742090316335, 6053.152558641882, 6105.145279660762, 6137.285055221685, 6214.751409943552, 6241.188645476241], "value": 5931.049552900383, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.2143641993804, 766.4098644044086, 790.0558832195527, 1092.2136062035336, 1097.9341239525634, 34883.65116348836, 34896.82551587241, 34986.475202871916, 35030.47454288188, 35130.82434587827, 36710.8164459178, 37055.629443705555, 37101.25797484049, 37179.62820371802, 37197.62802371976, 7089.929100708979, 7136.75021374252, 7201.819954501127, 7237.312455316736, 7372.815679607999, 7151.427885769126, 7236.71053157873, 7252.601106939116, 7261.2012678605315, 7265.4550908681795, 7198.496105272633, 7211.423086153095, 7270.27297270274, 7280.762270414042, 7294.598797066159, 7234.385077268412, 7238.0, 7261.491695581285, 7264.636768161571, 7270.163931147933, 7131.393831524327, 7132.786016419515, 7175.174854891702, 7183.784486465414, 7193.712251509934, 34342.82828585866, 34531.482027769605, 34563.13592160216, 34624.826875865714, 34696.479552806726, 3392.6098498672477, 3457.792532448061, 3470.722342212617, 3472.8263586820813, 3487.0410637074756, 27706.445871082466, 27785.72214277872, 27810.3047423814, 27818.165455036382, 27877.442451151066, 3617.5116359291687, 3628.818559072036, 3638.3632864248652, 3642.817859107034, 3648.927021459556, 139862.0, 142009.28995355061, 155608.0, 166635.0, 167294.16352918278, 42610.78694606507, 42646.78676606597, 42778.35832462516, 42892.78553607212, 42925.570744292156, 45049.0, 45213.32180017302, 45379.0, 47870.5212947873, 48523.5147648526, 12943.352832358345, 13040.087193896336, 13046.739065218642, 13055.0, 13255.536056237985, 10485.790284194274, 10492.790144197073, 10504.73738156537, 10542.42016689074, 10573.365598064142, 13654.249016304, 13689.931550342184, 13694.315284235749, 13770.449182032808, 13899.930500347433, 5452.372977107604, 5509.724513774296, 5531.3362396512675, 5565.415631358649, 5593.161025846156, 960.313375936195, 961.9759506012406, 968.9321747477609, 973.7030205787303, 991.3407583956732, 21827.015355086536, 21962.89018554897, 22486.212982545534, 23246.0, 23325.76674233236, 1035.7255327338262, 1042.6611351310855, 1056.572088304238, 1101.6860194844592, 1105.3478447715725, 11614.593489228006, 11753.823692644617, 12374.938125309496, 12381.75236495265, 12392.62822115338, 212500.0, 212722.0, 213069.0, 214367.0, 214624.0, 47181.0, 47224.5277547227, 47243.5275647246, 47269.527304726515, 47273.763631182315, 1391.589481103077, 1413.4134334251376, 1422.1680317014454, 1439.8344190418236, 1444.5810714892773, 21081.0, 21844.781552184275, 23371.766282336957, 23443.648345275175, 23746.168884088973, 34533.82733086318, 42776.358354624084, 43903.78048109739, 44223.557764421945, 44248.11503769971, 184905.0, 185583.0, 185924.0, 186385.0, 186389.0, 31598.842005789826, 32965.0, 33631.327373452885, 33668.0, 33668.66331336655, 39606.603933960294, 40256.79871600623, 40535.0, 40788.79605601953, 40864.38703419392, 27835.721642783312, 29277.0, 29850.910436269252, 30726.539101913044, 31530.527042094847, 29811.552826707182, 29853.850730746206, 29891.0, 30105.0, 31577.21056973594, 33584.32831343408, 33659.831700841336, 33719.15702107467, 34510.30979380449, 34710.9586712399, 29538.750737418435, 29620.111396658136, 29681.70318296876, 30097.24756881008, 30442.543361850032, 21686.566268674855, 23725.762742372357, 23967.28098157058, 24414.389640258425, 24497.142600008916], "value": 15914.698851248579, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.2492426095159, 419.76197695573086, 430.410337837163, 430.4554738256107, 435.23181584503345, 14442.927785361058, 14737.557873263793, 19607.0, 20010.799892001058, 20111.899440502795, 20751.68872466914, 21499.355019349405, 21644.458888527795, 21698.132074717032, 21702.674459883114, 5805.854853628651, 5934.703264836762, 5962.821115366546, 5971.4327138921735, 5996.310424301196, 5835.912461313083, 5899.764009439617, 5919.1713160157615, 5927.940720592804, 5940.821775346746, 5669.0, 5858.2677165354335, 5863.882722345572, 5894.410558944092, 5908.704564771766, 5814.215080964079, 5853.619514731528, 5866.266716660418, 5869.090291004901, 5874.148248503964, 5245.160774276097, 5269.394019687747, 5272.31459910213, 5281.181416880389, 5294.020606187868, 23947.281581552583, 24164.0, 24193.758062419325, 24224.636630450557, 24309.756902430927, 1900.9904950475297, 1945.4455480188078, 1954.4234450837037, 1955.2081407030175, 1963.6269108869412, 15616.453424130215, 16320.183990800531, 16374.099424531645, 16468.341266349333, 16509.422170223985, 2169.8372622053407, 2203.5923354179527, 2241.7758224177614, 2243.0354947372625, 2253.5943530164564, 114908.0, 119454.27640130302, 120240.39879800632, 120463.0, 120476.0, 10970.396628185526, 11421.657350279505, 11422.0, 11427.314361138358, 11953.223040502513, 16129.354825807071, 16202.918985405233, 16218.351265949466, 16256.918715406584, 16306.75539866903, 8713.259372953244, 8910.019897811235, 8998.59506322217, 9008.774780630405, 9065.864012039825, 8642.913570864337, 8760.386772925835, 8763.69327073562, 8815.603297851612, 8820.0, 7314.0, 7385.778426647209, 7450.478466507401, 7461.962690186514, 7494.288042635941, 2092.989535052315, 2095.434232757147, 2108.2515706923823, 2117.8199853012356, 2188.6388745857075, 937.4422218779815, 969.1665167955553, 970.9263148575402, 983.9803203935882, 991.3902949686036, 17733.11334433273, 17977.910110449364, 18271.36050238235, 18484.0, 19067.0, 979.8334283171736, 983.9803203935882, 994.5773046455228, 1030.9432981186108, 1035.063267742694, 10189.694309170736, 11561.595344162914, 12889.806652900214, 13115.672108197181, 13181.472741090442, 447134.0, 447648.0, 448015.0, 455739.0, 457384.0, 101141.49429252806, 105209.47395263128, 105397.0, 105520.0, 105857.0, 1188.7087663522493, 1196.1328037173155, 1220.8962238209851, 1234.7530493901256, 1238.207547169812, 17070.658586828442, 17289.576130994086, 18386.540336491697, 19151.616967660848, 19426.4172074838, 46756.766216168704, 47393.28910066283, 48533.5146648529, 48542.271865921335, 49026.264606031655, 62733.0, 62865.37134628595, 63267.683661581395, 63398.0, 64158.35841641524, 9619.086186812241, 9710.514474276399, 9713.0, 9737.07497787709, 9746.9025309746, 15262.236888155327, 15779.28993195286, 15814.446494372642, 15869.365225390855, 15881.602959925633, 13292.268925209206, 13479.258640774851, 13859.79210311826, 14015.229162396166, 14067.366968486647, 12185.695357615776, 12499.0, 12637.68405789826, 12781.29702866314, 12800.551980680631, 13836.861631383557, 13884.375203116086, 14674.119552826865, 14844.332005059583, 14847.109173449628, 9762.267829912927, 9829.606815727577, 9841.360311579725, 9880.0, 9976.102150806462, 13181.670458238621, 13276.800847987095, 13326.400311986177, 13353.53262635803, 13373.264470454218], "value": 10140.870941578925, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1254.1158483269296, 1317.3084130831307, 1317.7628026955144, 1318.1695531814955, 1324.3245944568266, 10909.290896091748, 11406.828897566533, 11408.828867566983, 11446.427678616057, 11689.59086431975, 11279.661610151708, 11379.089672826174, 11453.0, 11457.541698332057, 11465.19743617945, 2397.184957114581, 2425.890834912433, 2438.4635380216323, 2439.8414103083333, 2450.191436825852, 2334.871582062986, 2350.3536527455003, 2357.6581395697613, 2358.151065616377, 2370.146747171017, 2209.8784566848817, 2229.1194977983687, 2231.2079211879714, 2238.820894328458, 2245.5621153875, 2300.930972070824, 2310.792028717415, 2316.872572008539, 2320.153144102407, 2323.233333000106, 2119.1205649655376, 2122.80894719476, 2131.3286314810784, 2244.494988627562, 2328.0, 10807.83788243177, 10881.673549793519, 10881.727956801064, 10885.673429797118, 10913.072388846958, 6137.96931015342, 6371.936280637181, 6374.490040796725, 6380.425761681471, 6385.904211436832, 3936.389859571771, 4040.333344998101, 4087.9386809197886, 4100.876973690794, 4127.318992366256, 1323.9801402978962, 1326.7545504081775, 1327.5353626230838, 1368.8699573540498, 1372.9176249424966, 16237.269322880498, 16369.754453683205, 16462.259198336105, 16463.094529800856, 16973.57566060846, 5295.205719142159, 5309.814156504503, 5446.700431476228, 5476.479734425223, 5485.835424937259, 12444.191127576678, 12446.0, 12531.310777907303, 12586.496540138292, 12591.874081259253, 5965.671888046112, 6056.273247210363, 6081.391860813883, 6094.17174847544, 6106.542009349317, 5567.749451274703, 5660.745266463019, 5686.488216060492, 5723.055695810228, 5780.682062486603, 4157.608561696155, 4171.290880550314, 4173.455821346121, 4240.1731662326165, 4240.321548552217, 1202.6271855724578, 1228.8341073954903, 1235.32057368447, 1247.9064070194772, 1257.7673130470891, 834.7579202031465, 861.5390765940192, 872.7556284240422, 880.7445840706251, 903.9548022598975, 6028.156058151862, 6197.0, 6232.189815323979, 6360.459360954371, 6428.871422571522, 621.2638023941644, 631.623061725443, 631.7094136697079, 639.4532674563275, 643.6427782580713, 4205.3902184183125, 4518.819247230074, 4624.1445332613575, 4627.976860115745, 4685.390899183084, 14083.507077252247, 14626.780598291034, 14695.77956330656, 14708.0, 14711.92644036773, 13789.379477923518, 14197.0, 14460.85539144616, 14468.638284042983, 14510.1293922365, 7898.60506974649, 8651.567421628893, 8809.647614095364, 8842.823143537093, 8859.557022148867, 5742.684152371659, 6765.864682706417, 6894.0, 6962.677091352627, 6977.7208911642965, 12709.618711438672, 13193.274369909363, 13391.464341426234, 13643.795343069663, 13733.587992360246, 12997.415116319598, 13065.0, 13125.60623181306, 13205.801912971505, 13213.933930330288, 9148.176664100263, 9483.857742133736, 9948.403095814274, 9951.850722239316, 10009.849852252077, 10990.835137473105, 11156.609518666808, 11169.832452513381, 11173.441327933733, 11183.440827958731, 8873.157050080232, 9009.774755630899, 9019.188273055457, 9099.454032758056, 9125.361224714206, 8798.208161265517, 8896.911030889609, 8979.640814367353, 9160.496172710566, 9319.30105242096, 7742.148363680103, 7945.960270198612, 7957.283844454027, 8006.279434850891, 8029.678812847421, 5330.573554115739, 5642.633228840113, 5745.712714364348, 5780.335261444988, 5868.178455016387, 5957.523398128226, 6013.63918164894, 6172.135900973777, 6190.288116866618, 6193.721282542387], "value": 5212.483220021772, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.2039838728993, 408.165301957497, 414.19645886979237, 414.2378024435039, 417.4802371048046, 5923.0, 6005.819825405245, 6188.133661287423, 6303.590266632666, 6325.493960483162, 5990.89168503826, 6136.171616831726, 6159.10692949522, 6162.691865406723, 6183.443490085891, 4985.900281994358, 4989.176785830334, 4990.850274491771, 5001.599872010231, 5005.299258103868, 5016.27264046713, 5019.196928491442, 5023.874403139914, 5040.243963405482, 5045.445001049881, 5000.799968001275, 5001.524855138756, 5015.720991147271, 5016.297718319438, 5029.0, 5039.496050394968, 5045.091883460976, 5054.545090941796, 5056.306137443942, 5062.31658726071, 4540.659450541222, 4544.750038747868, 4545.181867263891, 4552.339910712928, 4552.453705555321, 5959.318306761975, 6055.152278680988, 6080.574359794816, 6082.635041897456, 6088.838462345848, 5703.686297253649, 5715.0, 5715.971420142914, 5733.8566535836935, 5736.627119237236, 6562.60624362535, 6568.770093046721, 6572.5399222054475, 6582.440492558138, 6596.295518837302, 4910.975445122752, 4913.606911447076, 4922.163232250526, 4922.187839006559, 4922.26166075088, 6495.999999999953, 6799.796006119825, 6823.590584564942, 6873.725050997954, 6888.931110688879, 4634.652401069933, 4637.675362724577, 4641.2109941310055, 4665.2302370108555, 4691.1555919934735, 4696.929546056812, 4713.787879545429, 4718.0, 4725.480197178307, 4734.881627959328, 5421.512063914267, 5424.783008679688, 5437.809676661298, 5445.237666726662, 5454.290942177571, 6296.622202667763, 6449.709763060673, 6460.257070436866, 6470.741170353133, 6502.154719886385, 1598.5364244369234, 1635.9100249486155, 1637.3450619752196, 1638.7951506061743, 1638.942637007699, 1054.6572363981736, 1076.1014552848303, 1099.5821587796586, 1101.3336931156696, 1101.3391964821203, 5726.3700992890745, 5732.426757324234, 5738.713064346766, 5746.02317606008, 5757.280339957505, 6666.699998500079, 6678.599284042973, 6702.530822842452, 6704.0, 6718.428933540704, 5661.46216109469, 5665.49010589049, 5706.942930570641, 5710.942890571124, 5720.3707592165665, 3583.4266517357096, 3583.498310236569, 3583.8924832255075, 3590.1383667919513, 3600.4419315005694, 6477.352264773485, 6510.934890651033, 6513.772017979348, 6543.770968016097, 6543.836404089936, 6726.192856857208, 6789.932100679029, 6846.281140480178, 6854.485913556503, 6871.553349032297, 6217.823761683556, 6417.582857114273, 6458.967705161538, 6480.935190648033, 6515.4787616990525, 6677.799666010027, 6717.932820671731, 6764.492663050192, 6771.119754431892, 6804.4556435484055, 6674.632895190811, 6697.497687673542, 6707.195136583641, 6725.5628384156835, 6742.808587209079, 6321.652309123042, 6513.381228783258, 6539.6403197824575, 6571.5399922005, 6576.868462630816, 4593.379893714306, 4597.747123908083, 4609.423822022247, 4612.86161415158, 4623.237165867594, 6764.8499755040775, 6765.308672831792, 6767.424768894699, 6786.253512113565, 6825.590464572141, 6509.479241660751, 6550.213974323112, 6582.827666870017, 6607.537472376887, 6618.900716489353, 6546.18172728409, 6560.212774467094, 6562.671866406565, 6595.307492713196, 6612.768553100618, 6513.706883190173, 6522.934770652233, 6526.738930442919, 6554.918438457601, 6562.639054852029, 6584.242812076481, 6616.603003819786, 6622.569532980341, 6634.9004764927595, 6645.435138013323, 6390.33851198701, 6404.519661025349, 6434.4852411806005, 6447.742090316522, 6453.45145662624], "value": 4966.45147404745, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [797.7407342613652, 810.3436216664505, 823.3495538524564, 826.7974346285162, 841.983160336793, 16876.240569174384, 17266.568335791613, 17330.913345433288, 18953.33663321784, 20592.0, 18616.25534978599, 18653.347132850355, 18687.159077841497, 18894.338698145566, 18925.337613183543, 907.469130558624, 910.0489987962562, 914.1635403605693, 916.6104405627615, 930.3812964378681, 903.8870141232346, 968.0174622757906, 974.5468357213894, 976.6142373762359, 978.5792109392994, 1047.0942634621035, 1049.5014867937746, 1054.3146954479573, 1054.3305001324177, 1060.7295139739394, 1020.4285600063914, 1024.6772266735954, 1030.294248439821, 1032.4837581209395, 1035.2390992620456, 752.8381397999457, 756.3797685897566, 757.7385801898337, 758.6586036283694, 758.8482303539259, 16754.4135955241, 16976.320582878034, 17399.0, 17527.0, 17579.912100439546, 18061.548461288443, 18181.36365227224, 18308.359207427675, 18406.44780656569, 18631.0, 14554.0, 14843.92578037103, 14856.554303370916, 14886.478973235993, 14913.105213687106, 3337.215754297738, 3360.9663903360897, 3363.1760218746317, 3370.96629033709, 3459.3254315408503, 88145.11854881434, 89277.55361223282, 89485.0, 89645.55177224138, 90502.09497905003, 14332.355044023045, 14466.27668616565, 14546.272686365639, 14665.120092794466, 15044.0, 25879.0, 26579.867100664374, 26678.333041674112, 26712.732872671415, 26809.329766755596, 7905.723299684483, 7914.881276780853, 8236.876446853303, 8304.086550479442, 8358.205970432798, 3896.5324161100284, 4007.539132999684, 4024.3963405488826, 4038.374052021941, 4038.6163314485666, 4070.8575199868455, 4189.49726032878, 4204.285271503852, 4241.088166044316, 4419.337099435111, 836.0761358698551, 849.8512760266929, 857.0743596915316, 858.6908712863365, 866.2117473099449, 651.9087327774115, 673.1619134177882, 696.5368030259922, 703.4021082080293, 703.802935178151, 10564.471776411148, 11389.715257118638, 11978.940105299593, 12165.93917030427, 12487.687807804696, 667.5494041521953, 682.8566001139816, 687.556526040701, 691.934266244716, 706.321930946287, 4771.427428708508, 4941.283513890466, 5122.564582010496, 5160.587153027749, 5164.147915593885, 81316.59341703371, 81774.59112704398, 83605.0, 84072.57963710143, 86359.0, 67585.32414675888, 68827.65586172037, 68971.65514172397, 69085.3091469079, 69279.65360173267, 62324.68837655873, 63612.36387636157, 63691.36308636947, 64929.35070649328, 65656.67171664111, 10482.895171048192, 10831.512581933674, 11395.373254471084, 11460.770784584429, 12182.75634487323, 28028.71971280261, 28560.42879142364, 29010.0, 29031.7096829029, 29382.11853644394, 54002.0, 54089.45910541002, 54308.728456359044, 54503.18245226245, 56916.0, 14749.778753318924, 14794.482193123189, 14899.137607799024, 15045.172515511751, 15128.092314461168, 18448.0, 18939.810601894354, 19309.710354344414, 19646.312379066665, 20076.09657565384, 17023.404180854108, 17692.99219132776, 17965.461036168937, 18038.09809509493, 18186.45440636783, 16698.037774456057, 17351.045692487034, 17396.39112631052, 17453.127343633023, 17684.204210810803, 15923.681526369175, 16057.75913361324, 16107.597310067342, 16277.593060173116, 16359.67280654404, 10260.281780275309, 11650.184487086162, 12256.938715306367, 12395.008399327851, 12524.561640342909, 12209.938950305546, 12627.87372126267, 12976.0, 12985.935070324587, 13013.804792928304], "value": 8102.5350524104315, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 111.0, 110.0, 113.0, 110.0, 110.0, 111.0, 115.0, 112.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 118.0, 120.0, 171.0, 121.0, 120.0, 120.0, 125.0, 142.0, 122.0], "value": 130.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 166.0, 163.0, 164.0, 164.0, 166.0, 167.0, 176.0, 163.0, 162.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 78.0, 112.0, 74.0, 77.0, 76.0, 75.0, 105.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 105.0, 83.0, 83.0, 85.0, 97.0, 82.0, 87.0, 104.0], "value": 89.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 113.0, 114.0, 114.0, 114.0, 113.0, 114.0, 115.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 150.0, 151.0, 151.0, 153.0, 150.0, 152.0, 150.0, 155.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 58.0, 55.0, 55.0, 57.0, 58.0, 60.0, 57.0, 55.0, 59.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 56.0, 55.0, 55.0, 55.0, 54.0, 59.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 90.0, 85.0, 92.0, 98.0, 87.0, 87.0, 98.0, 105.0, 93.0], "value": 92.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 137.0, 136.0, 140.0, 138.0, 132.0, 132.0, 141.0, 133.0, 133.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 192.0, 189.0, 193.0, 197.0, 189.0, 191.0, 188.0, 190.0, 196.0], "value": 191.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 71.0, 77.0, 74.0, 77.0, 74.0, 71.0, 72.0, 74.0, 71.0], "value": 73.3, "unit": "score"}]}]} 12:19:46 INFO - Return code: 0 12:19:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:19:46 INFO - # TBPL SUCCESS # 12:19:46 INFO - Running post-action listener: _resource_record_post_action 12:19:46 INFO - [mozharness: 2017-06-04 19:19:46.663490Z] Finished run-tests step (success) 12:19:46 INFO - Running post-run listener: _resource_record_post_run 12:19:46 INFO - Total resource usage - Wall time: 1258s; CPU: 13.0%; Read bytes: 8744960; Write bytes: 434216960; Read time: 1812; Write time: 387868 12:19:46 INFO - TinderboxPrint: CPU usage
12.7% 12:19:46 INFO - TinderboxPrint: I/O read bytes / time
8,744,960 / 1,812 12:19:46 INFO - TinderboxPrint: I/O write bytes / time
434,216,960 / 387,868 12:19:46 INFO - TinderboxPrint: CPU idle
8,765.7 (87.3%) 12:19:46 INFO - TinderboxPrint: CPU user
1,213.6 (12.1%) 12:19:46 INFO - TinderboxPrint: Swap in / out
0 / 0 12:19:46 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 110202880; Read time: 0; Write time: 143428 12:19:46 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 12:19:46 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 6713344; Write bytes: 324014080; Read time: 1748; Write time: 244440 12:19:47 INFO - Running post-run listener: _upload_blobber_files 12:19:47 INFO - Blob upload gear active. 12:19:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:19:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 12:19:47 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'] 12:19:47 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 12:19:47 INFO - (blobuploader) - INFO - Open directory for files ... 12:19:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:19:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:19:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:19:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:19:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:19:48 INFO - (blobuploader) - INFO - Done attempting. 12:19:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:19:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:19:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:19:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:19:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:19:55 INFO - (blobuploader) - INFO - Done attempting. 12:19:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:19:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:19:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:19:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:19:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:19:56 INFO - (blobuploader) - INFO - Done attempting. 12:19:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:19:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:19:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:19:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:19:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:19:56 INFO - (blobuploader) - INFO - Done attempting. 12:19:56 INFO - (blobuploader) - INFO - Iteration through files over. 12:19:56 INFO - Return code: 0 12:19:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:19:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:19:56 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b01b8232349a6a87d88db0bec0c912e13766d64a8be49893f89acfad57d8b49c4eea3fb272c97e9758d49dbb2becfee83f67b03600013c7f3196050cef5c8e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d5b96a7bfd15e41f67e58968aeefb4567b62e865609bc3c33163a45d0e7e533af299b07c2cbfd8cfcfa116faf4af394331c132475d534d20aa3ee2940d8eca1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a650331346a67f0803509ebacea74705f81f860bd62e249573b6ef55b27f95f3b35d5d1bfb81c3849b1d1ca9b28ee71fdd10c930b75d491a98527d57e4405c9e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e386dd5edc3bd843e02f955673c6c5a8f1f169b43c39d491e2835c8b28c485bd5e6183de4e848b766c0605542e4011435d91e591e51ae72fed9e13993ad7b8ed"} 12:19:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:19:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:19:56 INFO - Contents: 12:19:56 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b01b8232349a6a87d88db0bec0c912e13766d64a8be49893f89acfad57d8b49c4eea3fb272c97e9758d49dbb2becfee83f67b03600013c7f3196050cef5c8e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d5b96a7bfd15e41f67e58968aeefb4567b62e865609bc3c33163a45d0e7e533af299b07c2cbfd8cfcfa116faf4af394331c132475d534d20aa3ee2940d8eca1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a650331346a67f0803509ebacea74705f81f860bd62e249573b6ef55b27f95f3b35d5d1bfb81c3849b1d1ca9b28ee71fdd10c930b75d491a98527d57e4405c9e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e386dd5edc3bd843e02f955673c6c5a8f1f169b43c39d491e2835c8b28c485bd5e6183de4e848b766c0605542e4011435d91e591e51ae72fed9e13993ad7b8ed"} 12:19:56 INFO - Running post-run listener: copy_logs_to_upload_dir 12:19:56 INFO - Copying logs to upload dir... 12:19:56 INFO - mkdir: /builds/slave/test/build/upload/logs 12:19:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1320.530535 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2017-06-04 12:19:56.973353) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-04 12:19:56.981911) ========= 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=5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233 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/9b01b8232349a6a87d88db0bec0c912e13766d64a8be49893f89acfad57d8b49c4eea3fb272c97e9758d49dbb2becfee83f67b03600013c7f3196050cef5c8e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d5b96a7bfd15e41f67e58968aeefb4567b62e865609bc3c33163a45d0e7e533af299b07c2cbfd8cfcfa116faf4af394331c132475d534d20aa3ee2940d8eca1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a650331346a67f0803509ebacea74705f81f860bd62e249573b6ef55b27f95f3b35d5d1bfb81c3849b1d1ca9b28ee71fdd10c930b75d491a98527d57e4405c9e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e386dd5edc3bd843e02f955673c6c5a8f1f169b43c39d491e2835c8b28c485bd5e6183de4e848b766c0605542e4011435d91e591e51ae72fed9e13993ad7b8ed"} build_url:https://queue.taskcluster.net/v1/task/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011067 build_url: 'https://queue.taskcluster.net/v1/task/XeTiw3l4Tp6sQcvKcQ0p-w/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9b01b8232349a6a87d88db0bec0c912e13766d64a8be49893f89acfad57d8b49c4eea3fb272c97e9758d49dbb2becfee83f67b03600013c7f3196050cef5c8e3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4d5b96a7bfd15e41f67e58968aeefb4567b62e865609bc3c33163a45d0e7e533af299b07c2cbfd8cfcfa116faf4af394331c132475d534d20aa3ee2940d8eca1", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a650331346a67f0803509ebacea74705f81f860bd62e249573b6ef55b27f95f3b35d5d1bfb81c3849b1d1ca9b28ee71fdd10c930b75d491a98527d57e4405c9e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e386dd5edc3bd843e02f955673c6c5a8f1f169b43c39d491e2835c8b28c485bd5e6183de4e848b766c0605542e4011435d91e591e51ae72fed9e13993ad7b8ed"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-04 12:19:57.008567) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-04 12:19:57.008865) ========= 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=5bd038846534b2fdfa68eeae000001e2-1496600447.316297-2072758233 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004376 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-04 12:19:57.091248) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-04 12:19:57.094572) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-04 12:19:57.094873) ========= ========= Total master_lag: 0.18 =========