builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-083 starttime: 1496418926.83 results: success (0) revision: 87c745019518b1d6cd782534f2553721e5735657 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-02 08:55:26.833389) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-02 08:55:26.833757) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-02 08:55:26.834225) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-02 08:55:26.858751) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 08:55:26.859555) ========= 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=3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-02 08:55:26-- 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.5M=0s 2017-06-02 08:55:26 (42.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.092132 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 08:55:26.973346) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 08:55:26.973629) ========= 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=3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023563 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 08:55:27.022815) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-02 08:55:27.023105) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 87c745019518b1d6cd782534f2553721e5735657 --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 87c745019518b1d6cd782534f2553721e5735657 --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=3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-02 08:55:27,111 truncating revision to first 12 chars 2017-06-02 08:55:27,111 Setting DEBUG logging. 2017-06-02 08:55:27,112 attempt 1/10 2017-06-02 08:55:27,112 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/87c745019518?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-02 08:55:28,272 unpacking tar archive at: mozilla-central-87c745019518/testing/mozharness/ program finished with exit code 0 elapsedTime=1.465187 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-06-02 08:55:28.501973) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-02 08:55:28.502278) ========= script_repo_revision: 87c745019518b1d6cd782534f2553721e5735657 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-02 08:55:28.502664) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-02 08:55:28.502930) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-02 08:55:28.511222) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-06-02 08:55:28.511508) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:55:28 INFO - MultiFileLogger online at 20170602 08:55:28 in /builds/slave/test 08:55:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:55:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:55:28 INFO - {'append_to_log': False, 08:55:28 INFO - 'base_work_dir': '/builds/slave/test', 08:55:28 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:55:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:55:28 INFO - 'branch': 'Firefox-Non-PGO', 08:55:28 INFO - 'buildbot_json_path': 'buildprops.json', 08:55:28 INFO - 'config_files': ('talos/linux_config.py',), 08:55:28 INFO - 'default_actions': ('clobber', 08:55:28 INFO - 'read-buildbot-config', 08:55:28 INFO - 'download-and-extract', 08:55:28 INFO - 'populate-webroot', 08:55:28 INFO - 'create-virtualenv', 08:55:28 INFO - 'install', 08:55:28 INFO - 'setup-mitmproxy', 08:55:28 INFO - 'run-tests'), 08:55:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:55:28 INFO - 'download_minidump_stackwalk': True, 08:55:28 INFO - 'download_symbols': 'ondemand', 08:55:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:55:28 INFO - 'tooltool.py': '/tools/tooltool.py', 08:55:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:55:28 INFO - '/tools/misc-python/virtualenv.py')}, 08:55:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:55:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:55:28 INFO - 'gecko_profile': False, 08:55:28 INFO - 'gecko_profile_interval': 0, 08:55:28 INFO - 'installer_path': 'installer.exe', 08:55:28 INFO - 'log_level': 'info', 08:55:28 INFO - 'log_name': 'talos', 08:55:28 INFO - 'log_to_console': True, 08:55:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:55:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:55:28 INFO - 'opt_config_files': (), 08:55:28 INFO - 'pip_index': False, 08:55:28 INFO - 'suite': 'dromaeojs-e10s', 08:55:28 INFO - 'system_bits': '32', 08:55:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:55:28 INFO - 'title': 'talos-linux64-ix-083', 08:55:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:55:28 INFO - 'use_talos_json': True, 08:55:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:55:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:55:28 INFO - 'work_dir': 'build'} 08:55:28 INFO - [mozharness: 2017-06-02 15:55:28.699558Z] Running clobber step. 08:55:28 INFO - Running pre-action listener: _resource_record_pre_action 08:55:28 INFO - Running main action method: clobber 08:55:28 INFO - rmtree: /builds/slave/test/build 08:55:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:55:29 INFO - Running post-action listener: _resource_record_post_action 08:55:29 INFO - [mozharness: 2017-06-02 15:55:29.717239Z] Finished clobber step (success) 08:55:29 INFO - [mozharness: 2017-06-02 15:55:29.717340Z] Running read-buildbot-config step. 08:55:29 INFO - Running pre-action listener: _resource_record_pre_action 08:55:29 INFO - Running main action method: read_buildbot_config 08:55:29 INFO - Using buildbot properties: 08:55:29 INFO - { 08:55:29 INFO - "project": "", 08:55:29 INFO - "product": "firefox", 08:55:29 INFO - "who": "ffxbld@noreply.mozilla.org", 08:55:29 INFO - "installer_path": "public/build/target.tar.bz2", 08:55:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:55:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:55:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:55:29 INFO - "stage_platform": "linux64", 08:55:29 INFO - "basedir": "/builds/slave/test", 08:55:29 INFO - "buildnumber": 927, 08:55:29 INFO - "platform": "ubuntu64_hw", 08:55:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:55:29 INFO - "slavebuilddir": "test", 08:55:29 INFO - "taskId": "ZIRW2yIIRieNCOROCqdzuw", 08:55:29 INFO - "branch": "mozilla-central", 08:55:29 INFO - "script_repo_revision": "production", 08:55:29 INFO - "revision": "87c745019518b1d6cd782534f2553721e5735657", 08:55:29 INFO - "slavename": "talos-linux64-ix-083", 08:55:29 INFO - "repo_path": "mozilla-central" 08:55:29 INFO - } 08:55:29 INFO - Finding installer, test and symbols from parent task. 08:55:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZIRW2yIIRieNCOROCqdzuw'}, attempt #1 08:55:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZIRW2yIIRieNCOROCqdzuw'}, attempt #1 08:55:30 INFO - Task dependencies: E0vr8iksQx6TXHW5XHPIvQ 08:55:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ'}, attempt #1 08:55:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/target.tar.bz2 08:55:31 INFO - Set test_url: https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/test_packages.json 08:55:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/target.crashreporter-symbols.zip 08:55:31 INFO - Running post-action listener: _resource_record_post_action 08:55:31 INFO - [mozharness: 2017-06-02 15:55:31.091602Z] Finished read-buildbot-config step (success) 08:55:31 INFO - [mozharness: 2017-06-02 15:55:31.091820Z] Running download-and-extract step. 08:55:31 INFO - Running pre-action listener: _resource_record_pre_action 08:55:31 INFO - Running main action method: download_and_extract 08:55:31 INFO - mkdir: /builds/slave/test/build/tests 08:55: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')]} 08:55:31 INFO - trying https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/target.test_packages.json 08:55:31 INFO - Downloading https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:55:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:55:31 INFO - Downloaded 989 bytes. 08:55:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:55:31 INFO - Using the following test package requirements: 08:55:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:55:31 INFO - u'common': [u'target.common.tests.zip'], 08:55:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:55:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:55:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:55:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:55:31 INFO - u'mozbase': [u'target.common.tests.zip'], 08:55:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:55:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:55:31 INFO - u'web-platform': [u'target.common.tests.zip', 08:55:31 INFO - u'target.web-platform.tests.tar.gz'], 08:55:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:55:31 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:55:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/target.common.tests.zip 08:55:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:55:31 INFO - Fetch https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/target.common.tests.zip into memory 08:55:34 INFO - Content-Length response header: 65102453 08:55:34 INFO - Bytes received: 65102453 08:55:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:55:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/target.common.tests.zip 08:55:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:55:44 INFO - Fetch https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/target.common.tests.zip into memory 08:55:46 INFO - Content-Length response header: 65102453 08:55:46 INFO - Bytes received: 65102453 08:55:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/target.talos.tests.zip 08:55:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:55:59 INFO - Fetch https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/target.talos.tests.zip into memory 08:55:59 INFO - Content-Length response header: 14447425 08:55:59 INFO - Bytes received: 14447425 08:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:00 INFO - trying https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/target.tar.bz2 08:56:00 INFO - Downloading https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:56:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:56:02 INFO - Downloaded 58539510 bytes. 08:56:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/target.tar.bz2 08:56:02 INFO - mkdir: /builds/slave/test/properties 08:56:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:56:02 INFO - Writing to file /builds/slave/test/properties/build_url 08:56:02 INFO - Contents: 08:56:02 INFO - build_url:https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/target.tar.bz2 08:56:02 INFO - Running post-action listener: _resource_record_post_action 08:56:02 INFO - Running post-action listener: set_extra_try_arguments 08:56:02 INFO - [mozharness: 2017-06-02 15:56:02.777715Z] Finished download-and-extract step (success) 08:56:02 INFO - [mozharness: 2017-06-02 15:56:02.777938Z] Running populate-webroot step. 08:56:02 INFO - Running pre-action listener: _resource_record_pre_action 08:56:02 INFO - Running main action method: populate_webroot 08:56:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:56:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:56:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:56:02 INFO - '--tppagecycles', 08:56:02 INFO - '7'], 08:56:02 INFO - 'tests': ['tsvgm']}}, 08:56:02 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:56:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:56:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:56:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:56:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:56:02 INFO - 'talos_options': ['--disable-e10s'], 08:56:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:56:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:56:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:56:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:56:02 INFO - 'talos_options': ['--disable-e10s'], 08:56:02 INFO - 'tests': ['damp', 'tps']}, 08:56:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:56:02 INFO - 'tests': ['damp', 'tps']}, 08:56:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:56:02 INFO - 'tests': ['dromaeo_dom']}, 08:56:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:56:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:56:02 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:56:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:56:02 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:56:02 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:56:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:56:02 INFO - 'tests': ['a11yr', 08:56:02 INFO - 'ts_paint', 08:56:02 INFO - 'tpaint', 08:56:02 INFO - 'sessionrestore', 08:56:02 INFO - 'sessionrestore_no_auto_restore', 08:56:02 INFO - 'tabpaint']}, 08:56:02 INFO - 'other-e10s': {'tests': ['a11yr', 08:56:02 INFO - 'ts_paint', 08:56:02 INFO - 'tpaint', 08:56:02 INFO - 'sessionrestore', 08:56:02 INFO - 'sessionrestore_no_auto_restore', 08:56:02 INFO - 'tabpaint']}, 08:56:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:56:02 INFO - 'ts_paint', 08:56:02 INFO - 'tpaint', 08:56:02 INFO - 'sessionrestore', 08:56:02 INFO - 'sessionrestore_no_auto_restore', 08:56:02 INFO - 'tabpaint']}, 08:56:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:56:02 INFO - 'ts_paint', 08:56:02 INFO - 'tpaint', 08:56:02 INFO - 'sessionrestore', 08:56:02 INFO - 'sessionrestore_no_auto_restore', 08:56:02 INFO - 'tabpaint']}, 08:56:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:56:02 INFO - 'tests': ['a11yr', 08:56:02 INFO - 'ts_paint', 08:56:02 INFO - 'tpaint', 08:56:02 INFO - 'sessionrestore', 08:56:02 INFO - 'sessionrestore_no_auto_restore', 08:56:02 INFO - 'tabpaint']}, 08:56:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:56:02 INFO - 'tests': ['a11yr', 08:56:02 INFO - 'ts_paint', 08:56:02 INFO - 'tpaint', 08:56:02 INFO - 'sessionrestore', 08:56:02 INFO - 'sessionrestore_no_auto_restore', 08:56:02 INFO - 'tabpaint']}, 08:56:02 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:56:02 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:56:02 INFO - 'bloom_basic_ref']}, 08:56:02 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 08:56:02 INFO - 'talos_options': ['--mitmproxy', 08:56:02 INFO - 'mitmproxy-recording-1.mp', 08:56:02 INFO - '--firstNonBlankPaint'], 08:56:02 INFO - 'tests': ['Quantum_1']}, 08:56:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:56:02 INFO - 'tests': ['tsvgx', 08:56:02 INFO - 'tsvgr_opacity', 08:56:02 INFO - 'tart', 08:56:02 INFO - 'tscrollx', 08:56:02 INFO - 'cart', 08:56:02 INFO - 'tsvg_static']}, 08:56:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:56:02 INFO - 'tsvgr_opacity', 08:56:02 INFO - 'tart', 08:56:02 INFO - 'tscrollx', 08:56:02 INFO - 'cart', 08:56:02 INFO - 'tsvg_static']}, 08:56:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:56:02 INFO - 'talos_options': ['--disable-e10s'], 08:56:02 INFO - 'tests': ['tp5o']}, 08:56:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:56:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:56:02 INFO - 'talos_options': ['--disable-e10s', 08:56:02 INFO - '--xperf_path', 08:56:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:56:02 INFO - 'tests': ['tp5n']}, 08:56:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:56:02 INFO - 'talos_options': ['--xperf_path', 08:56:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:56:02 INFO - 'tests': ['tp5n']}}, 08:56:02 INFO - 'talos.zip': {'path': '', 08:56:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:56:02 INFO - Running post-action listener: _resource_record_post_action 08:56:02 INFO - [mozharness: 2017-06-02 15:56:02.797729Z] Finished populate-webroot step (success) 08:56:02 INFO - [mozharness: 2017-06-02 15:56:02.797824Z] Running create-virtualenv step. 08:56:02 INFO - Running pre-action listener: _resource_record_pre_action 08:56:02 INFO - Running main action method: create_virtualenv 08:56:02 INFO - Creating virtualenv /builds/slave/test/build/venv 08:56:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:56:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:56:02 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 08:56:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:56:02 INFO - Using real prefix '/usr' 08:56:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:56:03 INFO - Installing distribute.............................................................................................................................................................................................done. 08:56:05 INFO - Installing pip.................done. 08:56:05 INFO - Return code: 0 08:56:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:56:05 INFO - Reading from file tmpfile_stdout 08:56:05 INFO - Output received: 08:56:05 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:56:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1588dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585840>, '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 0x1586740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586bd0>, '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': '3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:56:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:56:05 INFO - Using env: {'DISPLAY': ':0', 08:56:05 INFO - 'HOME': '/home/cltbld', 08:56:05 INFO - 'LANG': 'en_US.UTF-8', 08:56:05 INFO - 'LANGUAGE': 'en_US:en', 08:56:05 INFO - 'LOGNAME': 'cltbld', 08:56:05 INFO - 'MAIL': '/var/mail/cltbld', 08:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:05 INFO - 'MOZ_NO_REMOTE': '1', 08:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:05 INFO - 'NO_EM_RESTART': '1', 08:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:05 INFO - 'PWD': '/builds/slave/test', 08:56:05 INFO - 'SHELL': '/bin/bash', 08:56:05 INFO - 'SHLVL': '1', 08:56:05 INFO - 'TERM': 'linux', 08:56:05 INFO - 'TMOUT': '86400', 08:56:05 INFO - 'USER': 'cltbld', 08:56:05 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457', 08:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:05 INFO - '_': '/tools/buildbot/bin/python'} 08:56:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:05 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:56:05 INFO - Cleaning up... 08:56:05 INFO - Return code: 0 08:56:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1588dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585840>, '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 0x1586740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586bd0>, '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': '3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:56:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:56:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:56:05 INFO - Using env: {'DISPLAY': ':0', 08:56:05 INFO - 'HOME': '/home/cltbld', 08:56:05 INFO - 'LANG': 'en_US.UTF-8', 08:56:05 INFO - 'LANGUAGE': 'en_US:en', 08:56:05 INFO - 'LOGNAME': 'cltbld', 08:56:05 INFO - 'MAIL': '/var/mail/cltbld', 08:56:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:05 INFO - 'MOZ_NO_REMOTE': '1', 08:56:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:05 INFO - 'NO_EM_RESTART': '1', 08:56:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:05 INFO - 'PWD': '/builds/slave/test', 08:56:05 INFO - 'SHELL': '/bin/bash', 08:56:05 INFO - 'SHLVL': '1', 08:56:05 INFO - 'TERM': 'linux', 08:56:05 INFO - 'TMOUT': '86400', 08:56:05 INFO - 'USER': 'cltbld', 08:56:05 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457', 08:56:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:05 INFO - '_': '/tools/buildbot/bin/python'} 08:56:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:06 INFO - Downloading/unpacking psutil>=3.1.1 08:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:56:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:56:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:56:07 INFO - Installing collected packages: psutil 08:56:07 INFO - Running setup.py install for psutil 08:56:07 INFO - building 'psutil._psutil_linux' extension 08:56:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:56:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:56:07 INFO - building 'psutil._psutil_posix' extension 08:56:07 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:56:07 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:56:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:56:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:56:07 INFO - Successfully installed psutil 08:56:07 INFO - Cleaning up... 08:56:07 INFO - Return code: 0 08:56:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:07 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 0x120a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1588dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585840>, '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 0x1586740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586bd0>, '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': '3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:56:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:56:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:56:07 INFO - Using env: {'DISPLAY': ':0', 08:56:07 INFO - 'HOME': '/home/cltbld', 08:56:07 INFO - 'LANG': 'en_US.UTF-8', 08:56:07 INFO - 'LANGUAGE': 'en_US:en', 08:56:07 INFO - 'LOGNAME': 'cltbld', 08:56:07 INFO - 'MAIL': '/var/mail/cltbld', 08:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:07 INFO - 'MOZ_NO_REMOTE': '1', 08:56:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:07 INFO - 'NO_EM_RESTART': '1', 08:56:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:07 INFO - 'PWD': '/builds/slave/test', 08:56:07 INFO - 'SHELL': '/bin/bash', 08:56:07 INFO - 'SHLVL': '1', 08:56:07 INFO - 'TERM': 'linux', 08:56:07 INFO - 'TMOUT': '86400', 08:56:07 INFO - 'USER': 'cltbld', 08:56:07 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457', 08:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:07 INFO - '_': '/tools/buildbot/bin/python'} 08:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:09 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:56:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:56:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:56:09 INFO - Installing collected packages: mozsystemmonitor 08:56:09 INFO - Running setup.py install for mozsystemmonitor 08:56:09 INFO - Successfully installed mozsystemmonitor 08:56:09 INFO - Cleaning up... 08:56:09 INFO - Return code: 0 08:56:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1588dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585840>, '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 0x1586740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586bd0>, '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': '3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:56:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:56:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:56:09 INFO - Using env: {'DISPLAY': ':0', 08:56:09 INFO - 'HOME': '/home/cltbld', 08:56:09 INFO - 'LANG': 'en_US.UTF-8', 08:56:09 INFO - 'LANGUAGE': 'en_US:en', 08:56:09 INFO - 'LOGNAME': 'cltbld', 08:56:09 INFO - 'MAIL': '/var/mail/cltbld', 08:56:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:09 INFO - 'MOZ_NO_REMOTE': '1', 08:56:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:09 INFO - 'NO_EM_RESTART': '1', 08:56:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:09 INFO - 'PWD': '/builds/slave/test', 08:56:09 INFO - 'SHELL': '/bin/bash', 08:56:09 INFO - 'SHLVL': '1', 08:56:09 INFO - 'TERM': 'linux', 08:56:09 INFO - 'TMOUT': '86400', 08:56:09 INFO - 'USER': 'cltbld', 08:56:09 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457', 08:56:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:09 INFO - '_': '/tools/buildbot/bin/python'} 08:56:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:09 INFO - Downloading/unpacking jsonschema==2.5.1 08:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:56:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:10 INFO - Downloading functools32-3.2.3-2.tar.gz 08:56:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:56:10 INFO - warning: no files found matching '*.txt' 08:56:10 INFO - no previously-included directories found matching 'build' 08:56:10 INFO - no previously-included directories found matching 'dist' 08:56:10 INFO - no previously-included directories found matching '.git*' 08:56:10 INFO - Installing collected packages: jsonschema, functools32 08:56:10 INFO - Running setup.py install for functools32 08:56:10 INFO - warning: no files found matching '*.txt' 08:56:10 INFO - no previously-included directories found matching 'build' 08:56:10 INFO - no previously-included directories found matching 'dist' 08:56:10 INFO - no previously-included directories found matching '.git*' 08:56:10 INFO - Successfully installed jsonschema functools32 08:56:10 INFO - Cleaning up... 08:56:10 INFO - Return code: 0 08:56:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:56:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:10 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 0x120a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1588dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585840>, '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 0x1586740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586bd0>, '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': '3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:56:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:56:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:56:10 INFO - Using env: {'DISPLAY': ':0', 08:56:10 INFO - 'HOME': '/home/cltbld', 08:56:10 INFO - 'LANG': 'en_US.UTF-8', 08:56:10 INFO - 'LANGUAGE': 'en_US:en', 08:56:10 INFO - 'LOGNAME': 'cltbld', 08:56:10 INFO - 'MAIL': '/var/mail/cltbld', 08:56:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:10 INFO - 'MOZ_NO_REMOTE': '1', 08:56:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:10 INFO - 'NO_EM_RESTART': '1', 08:56:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:10 INFO - 'PWD': '/builds/slave/test', 08:56:10 INFO - 'SHELL': '/bin/bash', 08:56:10 INFO - 'SHLVL': '1', 08:56:10 INFO - 'TERM': 'linux', 08:56:10 INFO - 'TMOUT': '86400', 08:56:10 INFO - 'USER': 'cltbld', 08:56:10 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457', 08:56:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:10 INFO - '_': '/tools/buildbot/bin/python'} 08:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:56:11 INFO - Cleaning up... 08:56:11 INFO - Return code: 0 08:56:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1588dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585840>, '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 0x1586740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586bd0>, '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': '3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:56:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:56:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:56:11 INFO - Using env: {'DISPLAY': ':0', 08:56:11 INFO - 'HOME': '/home/cltbld', 08:56:11 INFO - 'LANG': 'en_US.UTF-8', 08:56:11 INFO - 'LANGUAGE': 'en_US:en', 08:56:11 INFO - 'LOGNAME': 'cltbld', 08:56:11 INFO - 'MAIL': '/var/mail/cltbld', 08:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:11 INFO - 'MOZ_NO_REMOTE': '1', 08:56:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:11 INFO - 'NO_EM_RESTART': '1', 08:56:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:11 INFO - 'PWD': '/builds/slave/test', 08:56:11 INFO - 'SHELL': '/bin/bash', 08:56:11 INFO - 'SHLVL': '1', 08:56:11 INFO - 'TERM': 'linux', 08:56:11 INFO - 'TMOUT': '86400', 08:56:11 INFO - 'USER': 'cltbld', 08:56:11 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457', 08:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:11 INFO - '_': '/tools/buildbot/bin/python'} 08:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:11 INFO - Downloading/unpacking blobuploader==1.2.4 08:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:12 INFO - Downloading blobuploader-1.2.4.tar.gz 08:56:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:56:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:56:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:13 INFO - Downloading docopt-0.6.1.tar.gz 08:56:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:56:13 INFO - Installing collected packages: blobuploader, requests, docopt 08:56:13 INFO - Running setup.py install for blobuploader 08:56:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:56:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:56:13 INFO - Running setup.py install for requests 08:56:13 INFO - Running setup.py install for docopt 08:56:13 INFO - Successfully installed blobuploader requests docopt 08:56:13 INFO - Cleaning up... 08:56:13 INFO - Return code: 0 08:56:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1588dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585840>, '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 0x1586740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586bd0>, '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': '3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:56:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:56:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:56:13 INFO - Using env: {'DISPLAY': ':0', 08:56:13 INFO - 'HOME': '/home/cltbld', 08:56:13 INFO - 'LANG': 'en_US.UTF-8', 08:56:13 INFO - 'LANGUAGE': 'en_US:en', 08:56:13 INFO - 'LOGNAME': 'cltbld', 08:56:13 INFO - 'MAIL': '/var/mail/cltbld', 08:56:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:13 INFO - 'MOZ_NO_REMOTE': '1', 08:56:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:13 INFO - 'NO_EM_RESTART': '1', 08:56:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:13 INFO - 'PWD': '/builds/slave/test', 08:56:13 INFO - 'SHELL': '/bin/bash', 08:56:13 INFO - 'SHLVL': '1', 08:56:13 INFO - 'TERM': 'linux', 08:56:13 INFO - 'TMOUT': '86400', 08:56:13 INFO - 'USER': 'cltbld', 08:56:13 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457', 08:56:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:13 INFO - '_': '/tools/buildbot/bin/python'} 08:56:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:56:14 INFO - Running setup.py (path:/tmp/pip-yRZF79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:56:14 INFO - Running setup.py (path:/tmp/pip-dFRfO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:56:14 INFO - Running setup.py (path:/tmp/pip-fZ0mYn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:56:14 INFO - Running setup.py (path:/tmp/pip-WE8tps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:56:14 INFO - Running setup.py (path:/tmp/pip-3ZkF6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:56:14 INFO - Running setup.py (path:/tmp/pip-l0RbtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:56:14 INFO - Running setup.py (path:/tmp/pip-Qrc9Cx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:56:14 INFO - Running setup.py (path:/tmp/pip-u4QST5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:56:14 INFO - Running setup.py (path:/tmp/pip-te2Oav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:56:14 INFO - Running setup.py (path:/tmp/pip-DaSbwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:56:14 INFO - Running setup.py (path:/tmp/pip-dBu4wX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:56:14 INFO - Running setup.py (path:/tmp/pip-pnqjVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:56:14 INFO - Running setup.py (path:/tmp/pip-_kEw1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:56:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:56:14 INFO - Running setup.py (path:/tmp/pip-U50MKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:15 INFO - Running setup.py (path:/tmp/pip-9qp0oL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:56:15 INFO - Running setup.py (path:/tmp/pip-HqPCXH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:56:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:56:15 INFO - Running setup.py (path:/tmp/pip-ntti0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:56:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:56:15 INFO - Running setup.py install for manifestparser 08:56:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:56:15 INFO - Running setup.py install for mozcrash 08:56:15 INFO - Running setup.py install for mozdebug 08:56:15 INFO - Running setup.py install for mozdevice 08:56:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:56:15 INFO - Running setup.py install for mozfile 08:56:15 INFO - Running setup.py install for mozhttpd 08:56:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:56:15 INFO - Running setup.py install for mozinfo 08:56:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:56:15 INFO - Running setup.py install for mozInstall 08:56:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:56:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:56:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:56:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:56:16 INFO - Running setup.py install for mozleak 08:56:16 INFO - Running setup.py install for mozlog 08:56:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:56:16 INFO - Running setup.py install for moznetwork 08:56:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:56:16 INFO - Running setup.py install for mozprocess 08:56:16 INFO - Running setup.py install for mozprofile 08:56:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:56:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:56:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:56:16 INFO - Running setup.py install for mozrunner 08:56:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:56:16 INFO - Running setup.py install for mozscreenshot 08:56:16 INFO - Running setup.py install for moztest 08:56:16 INFO - Running setup.py install for mozversion 08:56:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:56:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:56:16 INFO - Cleaning up... 08:56:17 INFO - Return code: 0 08:56:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1588dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585840>, '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 0x1586740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586bd0>, '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': '3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:56:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:56:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:56:17 INFO - Using env: {'DISPLAY': ':0', 08:56:17 INFO - 'HOME': '/home/cltbld', 08:56:17 INFO - 'LANG': 'en_US.UTF-8', 08:56:17 INFO - 'LANGUAGE': 'en_US:en', 08:56:17 INFO - 'LOGNAME': 'cltbld', 08:56:17 INFO - 'MAIL': '/var/mail/cltbld', 08:56:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:17 INFO - 'MOZ_NO_REMOTE': '1', 08:56:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:17 INFO - 'NO_EM_RESTART': '1', 08:56:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:17 INFO - 'PWD': '/builds/slave/test', 08:56:17 INFO - 'SHELL': '/bin/bash', 08:56:17 INFO - 'SHLVL': '1', 08:56:17 INFO - 'TERM': 'linux', 08:56:17 INFO - 'TMOUT': '86400', 08:56:17 INFO - 'USER': 'cltbld', 08:56:17 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457', 08:56:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:17 INFO - '_': '/tools/buildbot/bin/python'} 08:56:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:56:17 INFO - Running setup.py (path:/tmp/pip-fqYUI4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:56:17 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:56:17 INFO - Running setup.py (path:/tmp/pip-6Xq3qN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:56:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:56:17 INFO - Running setup.py (path:/tmp/pip-0VBGkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:56:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:56:17 INFO - Running setup.py (path:/tmp/pip-5dFwCw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:56:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:56:17 INFO - Running setup.py (path:/tmp/pip-Ny9YiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:56:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:56:17 INFO - Running setup.py (path:/tmp/pip-zcPiS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:56:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:56:17 INFO - Running setup.py (path:/tmp/pip-frxLUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:56:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:56:17 INFO - Running setup.py (path:/tmp/pip-f9Tip6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:56:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:56:17 INFO - Running setup.py (path:/tmp/pip-gdDHi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:56:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:56:17 INFO - Running setup.py (path:/tmp/pip-_id5Wl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:56:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:56:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:56:17 INFO - Running setup.py (path:/tmp/pip-upBiWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:56:18 INFO - Running setup.py (path:/tmp/pip-ULFBna-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:56:18 INFO - Running setup.py (path:/tmp/pip-n5az1i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:56:18 INFO - Running setup.py (path:/tmp/pip-JcL7WK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:18 INFO - Running setup.py (path:/tmp/pip-x0FaO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:56:18 INFO - Running setup.py (path:/tmp/pip-o3fM9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:56:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:56:18 INFO - Running setup.py (path:/tmp/pip-z7TFMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:56:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:56:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:19 INFO - Downloading blessings-1.6.tar.gz 08:56:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:56:19 INFO - Installing collected packages: blessings 08:56:19 INFO - Running setup.py install for blessings 08:56:19 INFO - Successfully installed blessings 08:56:19 INFO - Cleaning up... 08:56:19 INFO - Return code: 0 08:56:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:56:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:56:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:56:19 INFO - Reading from file tmpfile_stdout 08:56:19 INFO - Current package versions: 08:56:19 INFO - argparse == 1.2.1 08:56:19 INFO - blessings == 1.6 08:56:19 INFO - blobuploader == 1.2.4 08:56:19 INFO - docopt == 0.6.1 08:56:19 INFO - functools32 == 3.2.3-2 08:56:19 INFO - jsonschema == 2.5.1 08:56:19 INFO - manifestparser == 1.1 08:56:19 INFO - mozInstall == 1.12 08:56:19 INFO - mozcrash == 1.0 08:56:19 INFO - mozdebug == 0.1 08:56:19 INFO - mozdevice == 0.51 08:56:19 INFO - mozfile == 1.2 08:56:19 INFO - mozhttpd == 0.7 08:56:19 INFO - mozinfo == 0.9 08:56:19 INFO - mozleak == 0.1 08:56:19 INFO - mozlog == 3.4 08:56:19 INFO - moznetwork == 0.27 08:56:19 INFO - mozprocess == 0.25 08:56:19 INFO - mozprofile == 0.28 08:56:19 INFO - mozrunner == 6.13 08:56:19 INFO - mozscreenshot == 0.1 08:56:19 INFO - mozsystemmonitor == 0.3 08:56:19 INFO - moztest == 0.8 08:56:19 INFO - mozversion == 1.4 08:56:19 INFO - psutil == 3.1.1 08:56:19 INFO - requests == 1.2.3 08:56:19 INFO - wsgiref == 0.1.2 08:56:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1588dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585840>, '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 0x1586740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586bd0>, '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': '3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:56:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:56:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:56:20 INFO - Using env: {'DISPLAY': ':0', 08:56:20 INFO - 'HOME': '/home/cltbld', 08:56:20 INFO - 'LANG': 'en_US.UTF-8', 08:56:20 INFO - 'LANGUAGE': 'en_US:en', 08:56:20 INFO - 'LOGNAME': 'cltbld', 08:56:20 INFO - 'MAIL': '/var/mail/cltbld', 08:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:20 INFO - 'MOZ_NO_REMOTE': '1', 08:56:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:20 INFO - 'NO_EM_RESTART': '1', 08:56:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:20 INFO - 'PWD': '/builds/slave/test', 08:56:20 INFO - 'SHELL': '/bin/bash', 08:56:20 INFO - 'SHLVL': '1', 08:56:20 INFO - 'TERM': 'linux', 08:56:20 INFO - 'TMOUT': '86400', 08:56:20 INFO - 'USER': 'cltbld', 08:56:20 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457', 08:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:20 INFO - '_': '/tools/buildbot/bin/python'} 08:56:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:56:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:56:20 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:21 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:56:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:56:21 INFO - Installing collected packages: marionette-driver 08:56:21 INFO - Running setup.py install for marionette-driver 08:56:21 INFO - Successfully installed marionette-driver 08:56:21 INFO - Cleaning up... 08:56:21 INFO - Return code: 0 08:56:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x120a3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1588dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1585840>, '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 0x1586740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586bd0>, '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': '3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:56:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:56:21 INFO - Using env: {'DISPLAY': ':0', 08:56:21 INFO - 'HOME': '/home/cltbld', 08:56:21 INFO - 'LANG': 'en_US.UTF-8', 08:56:21 INFO - 'LANGUAGE': 'en_US:en', 08:56:21 INFO - 'LOGNAME': 'cltbld', 08:56:21 INFO - 'MAIL': '/var/mail/cltbld', 08:56:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:21 INFO - 'MOZ_NO_REMOTE': '1', 08:56:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:21 INFO - 'NO_EM_RESTART': '1', 08:56:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:21 INFO - 'PWD': '/builds/slave/test', 08:56:21 INFO - 'SHELL': '/bin/bash', 08:56:21 INFO - 'SHLVL': '1', 08:56:21 INFO - 'TERM': 'linux', 08:56:21 INFO - 'TMOUT': '86400', 08:56:21 INFO - 'USER': 'cltbld', 08:56:21 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457', 08:56:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:21 INFO - '_': '/tools/buildbot/bin/python'} 08:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:56:21 INFO - Cleaning up... 08:56:21 INFO - Return code: 0 08:56:21 INFO - Running post-action listener: _resource_record_post_action 08:56:21 INFO - Running post-action listener: _start_resource_monitoring 08:56:21 INFO - Starting resource monitoring. 08:56:21 INFO - [mozharness: 2017-06-02 15:56:21.797564Z] Finished create-virtualenv step (success) 08:56:21 INFO - [mozharness: 2017-06-02 15:56:21.798027Z] Running install step. 08:56:21 INFO - Running pre-action listener: _resource_record_pre_action 08:56:21 INFO - Running main action method: install 08:56:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:56:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:56:22 INFO - Reading from file tmpfile_stdout 08:56:22 INFO - Detecting whether we're running mozinstall >=1.0... 08:56:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:56:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:56:22 INFO - Reading from file tmpfile_stdout 08:56:22 INFO - Output received: 08:56:22 INFO - Usage: mozinstall [options] installer 08:56:22 INFO - Options: 08:56:22 INFO - -h, --help show this help message and exit 08:56:22 INFO - -d DEST, --destination=DEST 08:56:22 INFO - Directory to install application into. [default: 08:56:22 INFO - "/builds/slave/test"] 08:56:22 INFO - --app=APP Application being installed. [default: firefox] 08:56:22 INFO - mkdir: /builds/slave/test/build/application 08:56:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:56:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:56:39 INFO - Reading from file tmpfile_stdout 08:56:39 INFO - Output received: 08:56:39 INFO - /builds/slave/test/build/application/firefox/firefox 08:56:39 INFO - Running post-action listener: _resource_record_post_action 08:56:39 INFO - [mozharness: 2017-06-02 15:56:39.044253Z] Finished install step (success) 08:56:39 INFO - [mozharness: 2017-06-02 15:56:39.044530Z] Running setup-mitmproxy step. 08:56:39 INFO - Running pre-action listener: _resource_record_pre_action 08:56:39 INFO - Running main action method: setup_mitmproxy 08:56:39 INFO - Skipping: mitmproxy is not required 08:56:39 INFO - Running post-action listener: _resource_record_post_action 08:56:39 INFO - [mozharness: 2017-06-02 15:56:39.045656Z] Finished setup-mitmproxy step (success) 08:56:39 INFO - [mozharness: 2017-06-02 15:56:39.045875Z] Running run-tests step. 08:56:39 INFO - Running pre-action listener: _resource_record_pre_action 08:56:39 INFO - Running main action method: run_tests 08:56:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:56:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:56:39 INFO - Python 2.7.3 08:56:39 INFO - Return code: 0 08:56:39 INFO - grabbing minidump binary from tooltool 08:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:39 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 0x1585840>, '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 0x1586740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1586bd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:56:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:56:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:56:39 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:56:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:56:39 INFO - Return code: 0 08:56:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:56:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:56:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:56:39 INFO - ENV: RUST_BACKTRACE is now 1 08:56:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:56:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:56:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:56:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-083 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:56:39 INFO - Using env: {'DISPLAY': ':0', 08:56:39 INFO - 'HOME': '/home/cltbld', 08:56:39 INFO - 'LANG': 'en_US.UTF-8', 08:56:39 INFO - 'LANGUAGE': 'en_US:en', 08:56:39 INFO - 'LOGNAME': 'cltbld', 08:56:39 INFO - 'MAIL': '/var/mail/cltbld', 08:56:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:56:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:56:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:39 INFO - 'MOZ_NO_REMOTE': '1', 08:56:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:56:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:56:39 INFO - 'NO_EM_RESTART': '1', 08:56:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:56:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:39 INFO - 'PWD': '/builds/slave/test', 08:56:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:56:39 INFO - 'RUST_BACKTRACE': '1', 08:56:39 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 08:56:39 INFO - 'SHELL': '/bin/bash', 08:56:39 INFO - 'SHLVL': '1', 08:56:39 INFO - 'TERM': 'linux', 08:56:39 INFO - 'TMOUT': '86400', 08:56:39 INFO - 'USER': 'cltbld', 08:56:39 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457', 08:56:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:39 INFO - '_': '/tools/buildbot/bin/python'} 08:56:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:56:39 INFO - mozversion application_buildid: 20170602152329 08:56:39 INFO - mozversion application_changeset: 87c745019518b1d6cd782534f2553721e5735657 08:56:39 INFO - mozversion application_display_name: Nightly 08:56:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:56:39 INFO - mozversion application_name: Firefox 08:56:39 INFO - mozversion application_remotingname: firefox 08:56:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:56:39 INFO - mozversion application_vendor: Mozilla 08:56:39 INFO - mozversion application_version: 55.0a1 08:56:39 INFO - mozversion platform_buildid: 20170602152329 08:56:39 INFO - mozversion platform_changeset: 87c745019518b1d6cd782534f2553721e5735657 08:56:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:56:39 INFO - mozversion platform_version: 55.0a1 08:56:39 INFO - using testdate: 1496418999 08:56:39 INFO - actual date: 1496418999 08:56:39 INFO - starting webserver on 'localhost:46070' 08:56:39 INFO - SUITE-START | Running 2 tests 08:56:39 INFO - TEST-START | dromaeo_css 08:56:39 INFO - operating with platform_type : linux_ 08:56:39 INFO - Initialising browser for dromaeo_css test... 08:56:39 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46070/getInfo.html -profile /tmp/tmpULm6CK/profile 08:56:39 INFO - TEST-INFO | started process 4229 (/builds/slave/test/build/application/firefox/firefox http://localhost:46070/getInfo.html) 08:57:14 INFO - TEST-INFO | 4229: killed by SIGTERM 08:57:14 INFO - Browser initialized. 08:57:14 INFO - Running cycle 1/1 for dromaeo_css test... 08:57:14 INFO - TEST-INFO | started process 4436 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpULm6CK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:57:26 INFO - PID 4436 | RSS: Main: 188231680 08:57:26 INFO - PID 4436 | 09:00:27 INFO - PID 4436 | Cycle 1(1): loaded http://localhost:46070/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46070/tests/dromaeo/cssquery-ext.html) 09:00:28 INFO - PID 4436 | RSS: Main: 183336960 09:00:28 INFO - PID 4436 | 09:03:30 INFO - PID 4436 | Cycle 1(1): loaded http://localhost:46070/tests/dromaeo/cssquery-ext.html (next: http://localhost:46070/tests/dromaeo/cssquery-jquery.html) 09:03:31 INFO - PID 4436 | RSS: Main: 190607360 09:03:31 INFO - PID 4436 | 09:06:33 INFO - PID 4436 | Cycle 1(1): loaded http://localhost:46070/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46070/tests/dromaeo/cssquery-mootools.html) 09:06:33 INFO - PID 4436 | RSS: Main: 187387904 09:06:33 INFO - PID 4436 | 09:09:35 INFO - PID 4436 | Cycle 1(1): loaded http://localhost:46070/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46070/tests/dromaeo/cssquery-prototype.html) 09:09:36 INFO - PID 4436 | RSS: Main: 190091264 09:09:36 INFO - PID 4436 | 09:12:38 INFO - PID 4436 | Cycle 1(1): loaded http://localhost:46070/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46070/tests/dromaeo/cssquery-yui.html) 09:12:39 INFO - PID 4436 | RSS: Main: 190488576 09:12:39 INFO - PID 4436 | 09:15:41 INFO - PID 4436 | Cycle 1(1): loaded http://localhost:46070/tests/dromaeo/cssquery-yui.html (next: http://localhost:46070/tests/dromaeo/cssquery-dojo.html) 09:15:41 INFO - PID 4436 | RSS: Main: 188071936 09:15:41 INFO - PID 4436 | 09:15:41 INFO - PID 4436 | __start_tp_report 09:15:41 INFO - PID 4436 | _x_x_mozilla_page_load 09:15:41 INFO - PID 4436 | _x_x_mozilla_page_load_details 09:15:41 INFO - PID 4436 | |i|pagename|runs| 09:15:41 INFO - PID 4436 | |0;dojo.html;3144.231678134159;3145.98427007865;3157.2106973256687;3163.3673265346906;3184.808911465312;5908.704564771766;5978.970105149474;5979.192808970788;5990.490808281291;5998.82003539894;5993.940060599392;6008.639481631105;6048.606840555361;6110.938890611093;6111.908321375183;5456.8090116845915;5554.86112847179;5594.804181853616;5624.95317533653;5673.035583950738;5662.490375866171;5678.517326027292;5684.346300175471;5688.402717714643;5704.087346024637;5461.481159289861;5522.806701765419;5540.86147846303;5595;5609.102543593006;5561.054620714488;5597.552195824365;5619.016672082369;5635.154726790973;5641.266635337421;5555.055640541118;5559.499645031967;5567.220589117527;5577.972110139464;5586.441355864381;5893.970530147321;6022.69886505673;6043.214382130339;6043.607165534227;6046.0326347784585;6387.073874288202;6413.903791443132;6483.481321494269;6497.1553698019425;6532.314107018789;6556.639384833832;6569.868602627921;6580.407763301326;6586.637734924578;6592.76925307612;6039.365866584033;6067.514598832083;6068.059450785136;6079.209702738615;6087.421694938974;6523.151990241238;6584.967075164594;6611.900821487681;6688.197416310074;6703.396694297537;6139.768135342631;6247.344028876993;6270.905936410957;6380.9361906380345;6404.935950640527;6366.076918846741;6370.171877655967;6467.191601049869;6488.448481879093;6492.967535162294;6466.482681385478;6506.804795856132;6516.511261655395;6517.674116294166;6530.510211734139;6318.6524741138755;6406.743730250831;6408.807735767934;6541.247756507967;6556.475481961527;5331.893362132736;5340.519353258225;5368.8389348319615;5370.167624018283;5388.811391601275;4545.250033744395;4557.225271703818;4561.29299958507;4582.221022426195;4667.883302917387;5568.136938774496;5704.771809127588;5715.485606295453;5721.170430287585;5726.79956201531;6371;6410.967945160244;6516.706748196342;6525.184351956005;6528;5677.858053548612;5702;5708.086706127;5714.257146570919;5739;5785.82642520725;5791.739371728282;5795.82612521625;5796.913046304308;5807.593468457252;6113.871604717271;6203.96898015516;6227.408396202444;6310.558260921692;6327.240731112296;6520.967395163184;6578.8355291118105;6580.144581204604;6600.867982640416;6608.074869518176;6290.150829637941;6384.170057892445;6401.77593784234;6405.263394709482;6420.582662126947;6234.064890266496;6295.748170073146;6303.621782693053;6416.711247993945;6433.710483028369;6550.148480697479;6550.737970481127;6558.967205163944;6560.671966401756;6588.505862060269;6149.41580549847;6335.714892829926;6342.556021078481;6350.079238510482;6372.426481616677;6153.938460615336;6251.874962500816;6284.434400903758;6326.114343991937;6345.302016778243;6091.8781624366375;6189.071639254148;6284.811455656338;6307.810765677037;6308.369163083655;6312.43188113072;6331.841703957438;6369.33122022181;6392.68036598159;6408.679566021587;6179.721912513858;6218.284897236876;6233.376662333731;6239.625622462485;6242.1261023455845 09:15:41 INFO - PID 4436 | |1;ext.html;726.1105146195911;757.526545908807;774.9457537972343;986.0336869867525;987.2250283527433;35318;36645.26709465813;36688.08279793007;36706;36718.63281367186;39063.609363906355;39426;39457.21085578287;39519.802400988025;39574.80212598933;7238.1314242291;7398.6670599823;7407;7534.547927124363;7543.849123017536;7397.224666080156;7401.555906645592;7481.5885126318035;7481.6259187040705;7508.774736757906;7424.294692004251;7483.663235154404;7493.063367079115;7493.625318734069;7514.361279291239;7435.405167586607;7436.40508759298;7470.140933792629;7472.215417381179;7498.887516687254;7328.413726901835;7345.88981165283;7402.925970740277;7403.1486379066555;7404.96297518509;34915;35023.4746478803;35117.824410878035;35194.29611407783;35215.1196220094;3439.3809114359406;3474;3474.2877710069374;3475.0617333320115;3476.530668359764;27586.172414827586;27662.861685691645;27688;27758.44483110347;27791.444171116465;3551.183227857607;3552.182997910495;3557.8576856925692;3560.5549306336707;3585.085803120188;134654;137416;150291.24854375768;163669;165559;42794.572054279684;42818.57181428146;42836.35745463821;42958.78520607377;43051.56948430475;44833.32750008752;45081.32378014332;45218.32172517415;45355.09289814251;45403.772981135546;14542.418303267963;14609.488667896572;14612.342444590018;14663.19352435605;14683;11916.603767926099;11928;11928.34394108315;12003.699907502207;12044.51821927113;13707.177569345871;13782.93108534451;13870.930645346709;13886;13986.230757308242;5516.558675306046;5601.971990140023;5692.097030514467;5805.970970145122;5900.970495147497;951.6145960885852;1008.969730908074;1010.7523656704008;1013.5337744637402;1046.4715318763976;23397.649035264483;23872.28383148508;23886.64170037451;23890.163844265713;24094.39764005879;1095.2114477576133;1097.632293181793;1101.0475938313302;1101.300674071954;1105.5964572930823;12526.74946501065;12635.74728505443;12636.368181590884;12645.367731613567;12808.80786788199;204342;205075;206184;206268;206758;49079.26381104286;49228.26157607639;49713.751431243334;49826.750866245435;49936.99999999927;1374.924379159156;1414.1444426122255;1427.2435609127178;1436.1454934314067;1437.9856201437851;22458.326250212518;22851.657225141305;23715.169969051;23791.074472712502;23796.286111416684;36023.45964810478;36178;36271.274574507835;36413.27173456569;36424.45363319499;179296;179631.10184448995;180104;180578;181129;31938.520922185722;32195.20486312486;33444;33677.831610841786;33736.83131584425;41085;41217.793911030254;42137;42734.5726542743;42827;30230.395392092476;30333.544996825505;30627.846860765552;30993.8450307747;31437.842810785798;28852.278693032844;29709;29843.701562984093;31192.532112017885;31411.685883140875;33888;33910.66089339075;34179.48730768991;34185.82907085449;34220;28469.43061138724;29443.558346625246;29546.704532954394;29812.807487700247;31134.532982004836;23077.307680769605;24142.39644008914;24260.1508947186;24336.148234812405;24358 09:15:41 INFO - PID 4436 | |2;jquery.html;429.0732018839308;430.9396684464174;436.7008599109609;442.28350072881926;445.75037978731893;10840.512176952036;11252.38111903847;20410.285640002603;21267.36197914063;21363.57272854542;21647.242346517876;22462;22508.8874555627;22545;22558.88720556399;5886.087656413263;6050.334463209044;6051.636901785907;6064.4541991220785;6064.757409703607;5901.675407852566;5957.344692083867;5976.462118409342;5982.4316689914385;6038.667873266969;5662.745176467049;5894.233749612545;5942.5840191186635;5952.987992041341;5985.910211346833;5909.911351329733;5915.319738230116;5935.258092738408;5981.790637327695;5983.282006159246;5337.11937530307;5369.463053694639;5371.140617501181;5375.569954403638;5388.248819133797;24681.136160234484;24784.158455439436;24788.25635230928;25064.87467562669;25166.874165629237;1898.8765730227492;1919.606480671459;1923.8749481283812;1925.1433112265047;1932.7390802241657;16186.190690465548;16925.153742312836;16966.151692415453;16975.830241697673;17019.063951482665;2143.239150101707;2171.4354267890462;2207.1061220205843;2217.279384200125;2222.122261706633;116793.23291355644;118035.40982295033;118962;119154;119289;11042.227044106996;11472.885271147348;11633.59282425111;11639.243449175776;12147.210431321935;16574.502764917073;16592;16600.750988735177;16606.916965415097;16699.91650041742;8033.433480471252;8091.595420228965;8144.755657330171;8148.185181481923;8223.136570659995;7470.3276705096805;7543;7560.3573696236435;7685.42359323053;7690.846183076307;7608.429367797437;7643.235676432312;7659.961700191463;7708.460407771514;7725.768226953201;2117.6294148524253;2117.723447294165;2178.5533965537343;2194.813440857545;2205.3163519309064;933.3653115881266;969.4328817641617;970.8737864077766;998.6554638649654;1015.9085682288629;18902.621947560972;19032.238710451427;19663;19731.210751570063;19979.800201997794;1002.8545860850281;1019.6023550815188;1024.6260115058099;1027.4913917610832;1031.4481752262504;10414.947925260325;10713.35719856811;10760.3543787373;10799.83800242997;10873.130149588173;437193;442338;450998;455143;455158;95201;95794;96002;100172.4991375053;103220;1160.3154139057997;1175.1362748379934;1177.0289511153333;1180.144395313391;1185.229600759496;16440.83559164441;16593.585160370603;17111.57221069483;17168.656626867643;17172.484825455256;45182.32226516539;46161.230326180535;46763.766181168874;46876.29685554651;47329.76335118302;58619.70690146522;58877.70561147167;59105.70447147909;59204.40795591989;65608;9499.240060795259;9725.319227653996;9732.659356922473;9755.170810481188;9770;15776.68446631038;15872.92063539675;16037.919810400874;16108.355665773237;16378.672426551164;13257.66855828612;13432.126911750705;13706.177629342272;13816.792748108586;14187.929060354632;11883.346415947206;12149.878501214875;12491.687707807378;12882.911250056362;13739.313034348042;12902.225866448043;13150.934245328712;13263.469461221443;13433.059685821898;13598.524051658145;9205.30960177976;9384.765380865532;9433.528323583656;9517.762055948657;9595;13861.306934653428;13989.23059231752;14117.929410352883;14258;14480.34838432252 09:15:41 INFO - PID 4436 | |3;mootools.html;1296.2416986063154;1351.6350585341959;1366.8906487481001;1370.198433916159;1370.4038743146739;10761.730956726085;10915.836262456069;11190;11237.101031917458;11353.545858165684;10811.78376432471;11002.944985275082;11003;11033.337999720003;11035.062019728333;2369.1115831563206;2408.4460574067975;2408.4580969281947;2409.084547871806;2412.360724408033;2335.5795956727784;2383.940401489959;2390.940226494334;2391.2467572714627;2394.892229849661;2304.72343318802;2317.8493397929165;2319.7100362454694;2329.2662811214414;2335.789778919897;2228.765979572154;2264.19621034532;2270.2167752125492;2277.533105713325;2282.7260728712495;2210.6794514795424;2246.618074927266;2317.165820304689;2320.3619004773655;2327.1622216002224;10906.072983796386;11038.17213708967;11053.502592383362;11081.612143575017;11086.057685096777;6106.816795496142;6311.337309582474;6321.810345689591;6354.2692590352235;6357.268914074848;3466.324066806974;3643.890683279506;3721.0511319613324;3726.31063253299;3754.868579599728;1225.9019278457702;1232.3961258983124;1257.8553466351395;1272.6372983699694;1280.590211132438;15720;15813.130277834714;15864.36542538297;15952.680946381124;16359.754603681073;5111.284420181178;5151.2530683050745;5261.76322065508;5297.735113244399;5334.386545547234;11578.131640126856;11585.189036767346;11697.883021169679;11719.12106592009;11720.120990925714;6116.449519543263;6210.627362358273;6233.283172435137;6245.656488893063;6256.249250090018;5761.337446193657;5831.825045248649;5848.152017957373;5863.560232982543;5873.765049398062;4118.83761025464;4148.688848336386;4158.875233742992;4174.432723874856;4216.439917230644;1197.700574856286;1206.7827790997706;1225.8467691538558;1237.4408245610596;1250.46230121047;837.4891316297054;840.3445312656138;848.6605357856783;871.1071152069053;891.741394995444;6186.412290832363;6209.565330426827;6231.968840155861;6241.282252540925;6424.164858568356;619.0744836469507;622.5673157155733;628.8805127025851;644.5294934697697;646.6508085633799;4116.382542618631;4346.456692913386;4559.224931761609;4596.724196548218;4629.791659375336;14037;14510.492132775302;14562.927185364217;14589.85410145885;14611.707765844623;13468.191908485522;14008.369623366973;14045.85954140466;14076.225807580682;14190.716185676229;7166.104236970379;8385.874211886827;8636.17956294151;8659.523726194993;8667;5816.9127463088935;6696.497762667722;6887.139107611549;7152.177499587614;7196.856062878818;12035.939820300842;12137.21108127969;12368.072394570623;12389.75220495603;12392.81410778857;12122.636320910387;12171.634850954486;12199.878001219875;12300.876991229974;12382.380880956096;9294.25645948336;9567.952160239154;9570.234381249344;9576.138147566473;9665.033496650278;10591.364518128938;10746.355218686904;10755.193360497837;10763.784724305313;10786.137109031102;8889.333300002396;8891.066438023914;8957.776055598662;9181.403208791407;9338.486383248986;8587.742367728979;8640.697575584825;8675.696350627697;8862.822743544964;8937.508437036025;7576.696932122653;7581.431392645463;7651.617419129133;7672.80817979555;7698.153203147761;5905.822825315247;5912.320083190488;5938.910916336345;5957.314908785545;6081.27024757032;5498.120300751861;5561.8609534760335;5606.467385598362;5665.923474539824;5804 09:15:41 INFO - PID 4436 | |4;prototype.html;380.68213042109835;394.9328614135597;399.60638770810766;401.7950845069014;401.8472980267498;6005.849853753658;6193.801200573799;6200.782972595955;6201.441870231678;6212.689365531728;5934.287885453741;5936.732847021884;6009.188759517464;6016.60892042017;6042.728077236524;4721.504242054586;4742.454617718955;4744;4745;4745.406824146981;4541.977290113561;4737.834175803848;4755.690880092783;4758.119747846642;4760.666753327268;4658.976705116486;4665.813367465297;4672.135654903836;4675.696079754805;4687.992081702433;4658.1848176568965;4676.36869022681;4687.601553867926;4694.319323698061;4700.459447163552;4109.321961876287;4154.771487568182;4155.563665815106;4158.750474971481;4161.500619925629;5876.324222714357;6001.729922153513;6009.519238460956;6018.518518518508;6023.186869772569;5349;5371.328583927009;5377;5402.540784033323;5402.621816472849;6361.80914572559;6368.089573128043;6436.163298771176;6441.774537891151;6456.2575303840185;4520.367148599199;4532.184206842767;4535.433070866142;4540.250858608326;4542.659300552472;6459.450946669539;6471.223453185601;6623.834404139887;6754.155730533684;6831.146106736658;4598.666386747873;4604.102200070954;4616.676832621684;4623.976880115645;4636.884077898012;4659.347691323217;4677.742724150136;4696.272077827942;4696.976515117471;4717.646176536773;5329.786808527693;5341.866453338697;5361.383440904268;5373.9731301343245;5392.91910621341;6428.453581445536;6434.131392262078;6443.742250309935;6444.581102228434;6448.322926092693;1612;1627.3246602660001;1628.2265923686155;1630.1115891838976;1632.583691158747;1013.2198207380276;1084.9186311026704;1089.4008295437477;1104.4864138175788;1107.1419649771492;5787.536997040227;5788.21859049023;5809.157672137517;5809.838032393538;5817.127430885401;6626.445851729033;6645.5411497746145;6648.368405001517;6652.234992975869;6653.234877989094;5719.7426115824055;5728.882867840731;5776.364599894008;5793.594448388572;5797.376734514342;3495.0563347895927;3537.982310088433;3549.396602577568;3550.627184145679;3560.359135355661;6437.935620643733;6445.677716114175;6447.903281450782;6473.320301368382;6487.902681459782;6735.29279425663;6750.173625857536;6773.983902414579;6787.524873258923;6807.455403567802;6401.3278605746655;6408.58344207625;6453.290138084713;6457.806265811939;6467.51493637979;6565.80302590923;6592.670366481752;6636.203655561363;6639.900401494078;6661.933380666325;6539.901901471387;6561.639109849004;6584.432071492026;6594.868102638016;6600.966995164993;6025.517958563392;6386.552941294065;6394.232692076795;6450.741970321134;6502.512311576746;4604.332371806003;4608.792604332746;4618.353430519663;4619.653525985632;4636.721796692209;6366.872662546631;6608.273089960197;6623.807714611224;6716.664166791543;6720.991851222356;6413.775517856852;6421;6425.58233714807;6451.3226111257645;6474.352564743488;6441.742330306735;6456.903146452713;6477.935220647922;6486.610803351814;6497.512686548623;6328.272248691459;6332.398422149889;6339.96830015847;6357.364263573606;6396.872062558629;6448;6470.094186813756;6484.870302593828;6488.643124628191;6510.381513756186;6244.843878903063;6283.905741413974;6305.842353941188;6311.2426508819235;6317.210348706411 09:15:41 INFO - PID 4436 | |5;yui.html;792.4096548071687;815.2581151152452;821.4947807098634;830.9210624990624;831.9625616847242;16703.248353824078;17291.91354043228;17314.134293285333;17765.91117044413;19770.90114549429;16736.83263167368;16923.3230670773;17144.742828857576;17326.740098898495;17338.739918901225;965.859950307205;988.6737376665683;996.1433167475965;997.990020099797;1000.9899901001006;965.478641533571;1000.049952545085;1001.529281237817;1004.7638804880847;1010.3634710132607;1058.978820423591;1059.533805125746;1060.2154405739775;1060.2631171335925;1062.0123285344664;1049.8162821506244;1057.8889216632297;1058.4443167337172;1058.8888166742497;1060.7560261139904;765.8085478630343;765.9693612255503;768.1243382543904;770.9845803083907;773.872311068673;16229.188540573043;16830.24263908115;17390.21744021522;17516.824831751648;17548.29806807739;18507.722384164248;18628.534286642807;18694.06529673511;18734;18915.14881830321;15110.471133510384;15237.695246095016;15380;15397.615059623487;15440.536783896501;3297.851596678155;3334.4498157803932;3348.665133486656;3438.9828050859837;3476.600190978045;82344;84885;84955.15044849472;84996;85152;14294.428222871176;15263.465778697915;15608.687826243411;15708.21458927049;15722.13528255934;24919.501609967698;25643.230703078938;25707.74292257091;25904.481910362065;25928;8053.557054362066;8084.312833409226;8538.658453661908;8551.572421378905;8587.87118193215;3995.4006898965386;4071.572484889103;4074.7351422157467;4075.612816782401;4085.366768150882;4104.856330028435;4124.608162224584;4127.938080928789;4132.628063474302;4331.198728235287;839.8404303182498;855.1405837133765;862.3273846399818;869.4044579463088;869.7347309070794;673.1417442760421;677.7695583501535;704.7181127548919;705.3405066262958;707.2609123465991;10901.727456813644;11268.605598804166;11815.05479561633;11982.580609678795;12396.442160102817;670.4569298867932;688.4114082459525;703.1421665567999;707.3386383731125;713.3829237709344;5226.5818734501145;5321.600879934021;5494.697791621499;5572.554195664337;5654.74553645087;88538.55730721305;88969;89117;89918.55040724755;91966.54016729874;81632;82743.58628206821;82914.58542707248;83483.5825820867;83561;70542;70591;71206.64396678087;71618;73171.16715018927;10836.783264334512;11376.317420954769;11537.538498459968;11538.538458461568;11634.185607007428;30404.5439318406;30587.2353191172;30867.228319292197;30953.535696964114;31594.36811263716;38770.61229387783;38881;38967.415488767125;39236.60763392444;39563;14661.266936653337;14854.554363369116;15112.319945602694;15206.391744330103;15369.923150384177;18337.816621833612;19028.238870445028;19150.616987660447;19389.51526211856;19418.223271069;15796.92101539485;16952.830471695124;17126;17261.223244954257;17397.652046958738;17047.147642617572;17546.73679894828;17804.10979451048;17841.553961151076;17867.106644667976;16887.07121108351;17280.04959727227;17370.39203627867;17718;17755.733663994793;11859;11931.582394616147;12192.634220973385;12342.259464432163;12405.069619778733;12202.633920982385;13752.868691975784;13783.862161378258;14190.574282771533;14198.219097949712 09:15:41 INFO - PID 4436 | __end_tp_report 09:15:41 INFO - PID 4436 | __start_cc_report 09:15:41 INFO - PID 4436 | _x_x_mozilla_cycle_collect,370 09:15:41 INFO - PID 4436 | __end_cc_report 09:15:41 INFO - PID 4436 | __startTimestamp1496420141371__endTimestamp 09:15:41 INFO - PID 4436 | 09:15:41 INFO - PID 4436 | ------- Summary: start ------- 09:15:41 INFO - PID 4436 | Number of tests: 6 09:15:41 INFO - PID 4436 | 09:15:41 INFO - PID 4436 | [#0] dojo.html Cycles:165 Average:5990.84 Median:6203.97 stddev:673.72 (10.9%) stddev-sans-first:637.70 09:15:41 INFO - PID 4436 | Values: 3144.2 3146.0 3157.2 3163.4 3184.8 5908.7 5979.0 5979.2 5990.5 5998.8 5993.9 6008.6 6048.6 6110.9 6111.9 5456.8 5554.9 5594.8 5625.0 5673.0 5662.5 5678.5 5684.3 5688.4 5704.1 5461.5 5522.8 5540.9 5595.0 5609.1 5561.1 5597.6 5619.0 5635.2 5641.3 5555.1 5559.5 5567.2 5578.0 5586.4 5894.0 6022.7 6043.2 6043.6 6046.0 6387.1 6413.9 6483.5 6497.2 6532.3 6556.6 6569.9 6580.4 6586.6 6592.8 6039.4 6067.5 6068.1 6079.2 6087.4 6523.2 6585.0 6611.9 6688.2 6703.4 6139.8 6247.3 6270.9 6380.9 6404.9 6366.1 6370.2 6467.2 6488.4 6493.0 6466.5 6506.8 6516.5 6517.7 6530.5 6318.7 6406.7 6408.8 6541.2 6556.5 5331.9 5340.5 5368.8 5370.2 5388.8 4545.3 4557.2 4561.3 4582.2 4667.9 5568.1 5704.8 5715.5 5721.2 5726.8 6371.0 6411.0 6516.7 6525.2 6528.0 5677.9 5702.0 5708.1 5714.3 5739.0 5785.8 5791.7 5795.8 5796.9 5807.6 6113.9 6204.0 6227.4 6310.6 6327.2 6521.0 6578.8 6580.1 6600.9 6608.1 6290.2 6384.2 6401.8 6405.3 6420.6 6234.1 6295.7 6303.6 6416.7 6433.7 6550.1 6550.7 6559.0 6560.7 6588.5 6149.4 6335.7 6342.6 6350.1 6372.4 6153.9 6251.9 6284.4 6326.1 6345.3 6091.9 6189.1 6284.8 6307.8 6308.4 6312.4 6331.8 6369.3 6392.7 6408.7 6179.7 6218.3 6233.4 6239.6 6242.1 09:15:41 INFO - PID 4436 | 09:15:41 INFO - PID 4436 | [#1] ext.html Cycles:180 Average:34081.96 Median:34045.07 stddev:46600.15 (136.9%) stddev-sans-first:46663.57 09:15:41 INFO - PID 4436 | Values: 726.1 757.5 774.9 986.0 987.2 35318.0 36645.3 36688.1 36706.0 36718.6 39063.6 39426.0 39457.2 39519.8 39574.8 7238.1 7398.7 7407.0 7534.5 7543.8 7397.2 7401.6 7481.6 7481.6 7508.8 7424.3 7483.7 7493.1 7493.6 7514.4 7435.4 7436.4 7470.1 7472.2 7498.9 7328.4 7345.9 7402.9 7403.1 7405.0 34915.0 35023.5 35117.8 35194.3 35215.1 3439.4 3474.0 3474.3 3475.1 3476.5 27586.2 27662.9 27688.0 27758.4 27791.4 3551.2 3552.2 3557.9 3560.6 3585.1 134654.0 137416.0 150291.2 163669.0 165559.0 42794.6 42818.6 42836.4 42958.8 43051.6 44833.3 45081.3 45218.3 45355.1 45403.8 14542.4 14609.5 14612.3 14663.2 14683.0 11916.6 11928.0 11928.3 12003.7 12044.5 13707.2 13782.9 13870.9 13886.0 13986.2 5516.6 5602.0 5692.1 5806.0 5901.0 951.6 1009.0 1010.8 1013.5 1046.5 23397.6 23872.3 23886.6 23890.2 24094.4 1095.2 1097.6 1101.0 1101.3 1105.6 12526.7 12635.7 12636.4 12645.4 12808.8 204342.0 205075.0 206184.0 206268.0 206758.0 49079.3 49228.3 49713.8 49826.8 49937.0 1374.9 1414.1 1427.2 1436.1 1438.0 22458.3 22851.7 23715.2 23791.1 23796.3 36023.5 36178.0 36271.3 36413.3 36424.5 179296.0 179631.1 180104.0 180578.0 181129.0 31938.5 32195.2 33444.0 33677.8 33736.8 41085.0 41217.8 42137.0 42734.6 42827.0 30230.4 30333.5 30627.8 30993.8 31437.8 28852.3 29709.0 29843.7 31192.5 31411.7 33888.0 33910.7 34179.5 34185.8 34220.0 28469.4 29443.6 29546.7 29812.8 31134.5 23077.3 24142.4 24260.2 24336.1 24358.0 09:15:41 INFO - PID 4436 | 09:15:41 INFO - PID 4436 | [#2] jquery.html Cycles:180 Average:29976.15 Median:2206.21 stddev:75200.94 (3408.6%) stddev-sans-first:75379.18 09:15:41 INFO - PID 4436 | Values: 429.1 430.9 436.7 442.3 445.8 10840.5 11252.4 20410.3 21267.4 21363.6 21647.2 22462.0 22508.9 22545.0 22558.9 5886.1 6050.3 6051.6 6064.5 6064.8 5901.7 5957.3 5976.5 5982.4 6038.7 5662.7 5894.2 5942.6 5953.0 5985.9 5909.9 5915.3 5935.3 5981.8 5983.3 5337.1 5369.5 5371.1 5375.6 5388.2 24681.1 24784.2 24788.3 25064.9 25166.9 1898.9 1919.6 1923.9 1925.1 1932.7 16186.2 16925.2 16966.2 16975.8 17019.1 2143.2 2171.4 2207.1 2217.3 2222.1 116793.2 118035.4 118962.0 119154.0 119289.0 11042.2 11472.9 11633.6 11639.2 12147.2 16574.5 16592.0 16600.8 16606.9 16699.9 8033.4 8091.6 8144.8 8148.2 8223.1 7470.3 7543.0 7560.4 7685.4 7690.8 7608.4 7643.2 7660.0 7708.5 7725.8 2117.6 2117.7 2178.6 2194.8 2205.3 933.4 969.4 970.9 998.7 1015.9 18902.6 19032.2 19663.0 19731.2 19979.8 1002.9 1019.6 1024.6 1027.5 1031.4 10414.9 10713.4 10760.4 10799.8 10873.1 437193.0 442338.0 450998.0 455143.0 455158.0 95201.0 95794.0 96002.0 100172.5 103220.0 1160.3 1175.1 1177.0 1180.1 1185.2 16440.8 16593.6 17111.6 17168.7 17172.5 45182.3 46161.2 46763.8 46876.3 47329.8 58619.7 58877.7 59105.7 59204.4 65608.0 9499.2 9725.3 9732.7 9755.2 9770.0 15776.7 15872.9 16037.9 16108.4 16378.7 13257.7 13432.1 13706.2 13816.8 14187.9 11883.3 12149.9 12491.7 12882.9 13739.3 12902.2 13150.9 13263.5 13433.1 13598.5 9205.3 9384.8 9433.5 9517.8 9595.0 13861.3 13989.2 14117.9 14258.0 14480.3 09:15:41 INFO - PID 4436 | 09:15:41 INFO - PID 4436 | [#3] mootools.html Cycles:180 Average:6806.39 Median:3555.11 stddev:4292.21 (120.7%) stddev-sans-first:4284.28 09:15:41 INFO - PID 4436 | Values: 1296.2 1351.6 1366.9 1370.2 1370.4 10761.7 10915.8 11190.0 11237.1 11353.5 10811.8 11002.9 11003.0 11033.3 11035.1 2369.1 2408.4 2408.5 2409.1 2412.4 2335.6 2383.9 2390.9 2391.2 2394.9 2304.7 2317.8 2319.7 2329.3 2335.8 2228.8 2264.2 2270.2 2277.5 2282.7 2210.7 2246.6 2317.2 2320.4 2327.2 10906.1 11038.2 11053.5 11081.6 11086.1 6106.8 6311.3 6321.8 6354.3 6357.3 3466.3 3643.9 3721.1 3726.3 3754.9 1225.9 1232.4 1257.9 1272.6 1280.6 15720.0 15813.1 15864.4 15952.7 16359.8 5111.3 5151.3 5261.8 5297.7 5334.4 11578.1 11585.2 11697.9 11719.1 11720.1 6116.4 6210.6 6233.3 6245.7 6256.2 5761.3 5831.8 5848.2 5863.6 5873.8 4118.8 4148.7 4158.9 4174.4 4216.4 1197.7 1206.8 1225.8 1237.4 1250.5 837.5 840.3 848.7 871.1 891.7 6186.4 6209.6 6232.0 6241.3 6424.2 619.1 622.6 628.9 644.5 646.7 4116.4 4346.5 4559.2 4596.7 4629.8 14037.0 14510.5 14562.9 14589.9 14611.7 13468.2 14008.4 14045.9 14076.2 14190.7 7166.1 8385.9 8636.2 8659.5 8667.0 5816.9 6696.5 6887.1 7152.2 7196.9 12035.9 12137.2 12368.1 12389.8 12392.8 12122.6 12171.6 12199.9 12300.9 12382.4 9294.3 9568.0 9570.2 9576.1 9665.0 10591.4 10746.4 10755.2 10763.8 10786.1 8889.3 8891.1 8957.8 9181.4 9338.5 8587.7 8640.7 8675.7 8862.8 8937.5 7576.7 7581.4 7651.6 7672.8 7698.2 5905.8 5912.3 5938.9 5957.3 6081.3 5498.1 5561.9 5606.5 5665.9 5804.0 09:15:41 INFO - PID 4436 | 09:15:41 INFO - PID 4436 | [#4] prototype.html Cycles:180 Average:5346.55 Median:6009.35 stddev:1572.72 (26.2%) stddev-sans-first:1532.32 09:15:41 INFO - PID 4436 | Values: 380.7 394.9 399.6 401.8 401.8 6005.8 6193.8 6200.8 6201.4 6212.7 5934.3 5936.7 6009.2 6016.6 6042.7 4721.5 4742.5 4744.0 4745.0 4745.4 4542.0 4737.8 4755.7 4758.1 4760.7 4659.0 4665.8 4672.1 4675.7 4688.0 4658.2 4676.4 4687.6 4694.3 4700.5 4109.3 4154.8 4155.6 4158.8 4161.5 5876.3 6001.7 6009.5 6018.5 6023.2 5349.0 5371.3 5377.0 5402.5 5402.6 6361.8 6368.1 6436.2 6441.8 6456.3 4520.4 4532.2 4535.4 4540.3 4542.7 6459.5 6471.2 6623.8 6754.2 6831.1 4598.7 4604.1 4616.7 4624.0 4636.9 4659.3 4677.7 4696.3 4697.0 4717.6 5329.8 5341.9 5361.4 5374.0 5392.9 6428.5 6434.1 6443.7 6444.6 6448.3 1612.0 1627.3 1628.2 1630.1 1632.6 1013.2 1084.9 1089.4 1104.5 1107.1 5787.5 5788.2 5809.2 5809.8 5817.1 6626.4 6645.5 6648.4 6652.2 6653.2 5719.7 5728.9 5776.4 5793.6 5797.4 3495.1 3538.0 3549.4 3550.6 3560.4 6437.9 6445.7 6447.9 6473.3 6487.9 6735.3 6750.2 6774.0 6787.5 6807.5 6401.3 6408.6 6453.3 6457.8 6467.5 6565.8 6592.7 6636.2 6639.9 6661.9 6539.9 6561.6 6584.4 6594.9 6601.0 6025.5 6386.6 6394.2 6450.7 6502.5 4604.3 4608.8 4618.4 4619.7 4636.7 6366.9 6608.3 6623.8 6716.7 6721.0 6413.8 6421.0 6425.6 6451.3 6474.4 6441.7 6456.9 6477.9 6486.6 6497.5 6328.3 6332.4 6340.0 6357.4 6396.9 6448.0 6470.1 6484.9 6488.6 6510.4 6244.8 6283.9 6305.8 6311.2 6317.2 09:15:41 INFO - PID 4436 | 09:15:41 INFO - PID 4436 | [#5] yui.html Cycles:180 Average:19265.81 Median:25281.37 stddev:24157.43 (95.6%) stddev-sans-first:24185.37 09:15:41 INFO - PID 4436 | Values: 792.4 815.3 821.5 830.9 832.0 16703.2 17291.9 17314.1 17765.9 19770.9 16736.8 16923.3 17144.7 17326.7 17338.7 965.9 988.7 996.1 998.0 1001.0 965.5 1000.0 1001.5 1004.8 1010.4 1059.0 1059.5 1060.2 1060.3 1062.0 1049.8 1057.9 1058.4 1058.9 1060.8 765.8 766.0 768.1 771.0 773.9 16229.2 16830.2 17390.2 17516.8 17548.3 18507.7 18628.5 18694.1 18734.0 18915.1 15110.5 15237.7 15380.0 15397.6 15440.5 3297.9 3334.4 3348.7 3439.0 3476.6 82344.0 84885.0 84955.2 84996.0 85152.0 14294.4 15263.5 15608.7 15708.2 15722.1 24919.5 25643.2 25707.7 25904.5 25928.0 8053.6 8084.3 8538.7 8551.6 8587.9 3995.4 4071.6 4074.7 4075.6 4085.4 4104.9 4124.6 4127.9 4132.6 4331.2 839.8 855.1 862.3 869.4 869.7 673.1 677.8 704.7 705.3 707.3 10901.7 11268.6 11815.1 11982.6 12396.4 670.5 688.4 703.1 707.3 713.4 5226.6 5321.6 5494.7 5572.6 5654.7 88538.6 88969.0 89117.0 89918.6 91966.5 81632.0 82743.6 82914.6 83483.6 83561.0 70542.0 70591.0 71206.6 71618.0 73171.2 10836.8 11376.3 11537.5 11538.5 11634.2 30404.5 30587.2 30867.2 30953.5 31594.4 38770.6 38881.0 38967.4 39236.6 39563.0 14661.3 14854.6 15112.3 15206.4 15369.9 18337.8 19028.2 19150.6 19389.5 19418.2 15796.9 16952.8 17126.0 17261.2 17397.7 17047.1 17546.7 17804.1 17841.6 17867.1 16887.1 17280.0 17370.4 17718.0 17755.7 11859.0 11931.6 12192.6 12342.3 12405.1 12202.6 13752.9 13783.9 14190.6 14198.2 09:15:41 INFO - PID 4436 | -------- Summary: end -------- 09:15:41 INFO - PID 4436 | 09:15:42 INFO - TEST-INFO | 4436: exit 0 09:15:42 INFO - TEST-OK | dromaeo_css | took 1142921ms 09:15:42 INFO - TEST-START | kraken 09:15:42 INFO - operating with platform_type : linux_ 09:15:42 INFO - Initialising browser for kraken test... 09:15:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:46070/getInfo.html -profile /tmp/tmpEoGtub/profile 09:15:42 INFO - TEST-INFO | started process 4834 (/builds/slave/test/build/application/firefox/firefox http://localhost:46070/getInfo.html) 09:16:17 INFO - TEST-INFO | 4834: killed by SIGTERM 09:16:17 INFO - Browser initialized. 09:16:17 INFO - Running cycle 1/1 for kraken test... 09:16:17 INFO - TEST-INFO | started process 5037 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEoGtub/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:16:29 INFO - PID 5037 | RSS: Main: 188145664 09:16:29 INFO - PID 5037 | 09:16:31 INFO - PID 5037 | Cycle 1(1): loaded http://localhost:46070/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46070/tests/kraken/driver.html?testName=audio-beat-detection) 09:16:32 INFO - PID 5037 | RSS: Main: 191987712 09:16:32 INFO - PID 5037 | 09:16:35 INFO - PID 5037 | Cycle 1(1): loaded http://localhost:46070/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46070/tests/kraken/driver.html?testName=audio-dft) 09:16:35 INFO - PID 5037 | RSS: Main: 191197184 09:16:35 INFO - PID 5037 | 09:16:38 INFO - PID 5037 | Cycle 1(1): loaded http://localhost:46070/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46070/tests/kraken/driver.html?testName=audio-fft) 09:16:39 INFO - PID 5037 | RSS: Main: 186003456 09:16:39 INFO - PID 5037 | 09:16:41 INFO - PID 5037 | Cycle 1(1): loaded http://localhost:46070/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46070/tests/kraken/driver.html?testName=audio-oscillator) 09:16:42 INFO - PID 5037 | RSS: Main: 186769408 09:16:42 INFO - PID 5037 | 09:16:44 INFO - PID 5037 | Cycle 1(1): loaded http://localhost:46070/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46070/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:16:44 INFO - PID 5037 | RSS: Main: 186531840 09:16:44 INFO - PID 5037 | 09:16:47 INFO - PID 5037 | Cycle 1(1): loaded http://localhost:46070/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46070/tests/kraken/driver.html?testName=imaging-darkroom) 09:16:48 INFO - PID 5037 | RSS: Main: 188133376 09:16:48 INFO - PID 5037 | 09:16:52 INFO - PID 5037 | Cycle 1(1): loaded http://localhost:46070/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46070/tests/kraken/driver.html?testName=imaging-desaturate) 09:16:52 INFO - PID 5037 | RSS: Main: 187297792 09:16:52 INFO - PID 5037 | 09:16:55 INFO - PID 5037 | Cycle 1(1): loaded http://localhost:46070/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46070/tests/kraken/driver.html?testName=json-parse-financial) 09:16:56 INFO - PID 5037 | RSS: Main: 187838464 09:16:56 INFO - PID 5037 | 09:16:57 INFO - PID 5037 | Cycle 1(1): loaded http://localhost:46070/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46070/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:16:58 INFO - PID 5037 | RSS: Main: 188080128 09:16:58 INFO - PID 5037 | 09:17:00 INFO - PID 5037 | Cycle 1(1): loaded http://localhost:46070/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46070/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:17:00 INFO - PID 5037 | RSS: Main: 187559936 09:17:00 INFO - PID 5037 | 09:17:03 INFO - PID 5037 | Cycle 1(1): loaded http://localhost:46070/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46070/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:17:03 INFO - PID 5037 | RSS: Main: 187670528 09:17:03 INFO - PID 5037 | 09:17:06 INFO - PID 5037 | Cycle 1(1): loaded http://localhost:46070/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46070/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:17:07 INFO - PID 5037 | RSS: Main: 187617280 09:17:07 INFO - PID 5037 | 09:17:10 INFO - PID 5037 | Cycle 1(1): loaded http://localhost:46070/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46070/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:17:10 INFO - PID 5037 | RSS: Main: 187609088 09:17:10 INFO - PID 5037 | 09:17:12 INFO - PID 5037 | Cycle 1(1): loaded http://localhost:46070/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46070/tests/kraken/driver.html?testName=ai-astar) 09:17:13 INFO - PID 5037 | RSS: Main: 188784640 09:17:13 INFO - PID 5037 | 09:17:13 INFO - PID 5037 | __start_tp_report 09:17:13 INFO - PID 5037 | _x_x_mozilla_page_load 09:17:13 INFO - PID 5037 | _x_x_mozilla_page_load_details 09:17:13 INFO - PID 5037 | |i|pagename|runs| 09:17:13 INFO - PID 5037 | |0;ai-astar;102;112;110;111;110;111;109;111;109;110 09:17:13 INFO - PID 5037 | |1;audio-beat-detection;158;126;122;165;122;121;121;121;146;127 09:17:13 INFO - PID 5037 | |2;audio-dft;164;165;164;163;163;170;169;169;166;162 09:17:13 INFO - PID 5037 | |3;audio-fft;73;73;73;111;74;74;77;74;94;74 09:17:13 INFO - PID 5037 | |4;audio-oscillator;86;85;107;86;82;81;97;83;84;114 09:17:13 INFO - PID 5037 | |5;imaging-gaussian-blur;114;116;113;113;113;114;115;114;113;115 09:17:13 INFO - PID 5037 | |6;imaging-darkroom;151;152;150;151;152;151;150;150;151;152 09:17:13 INFO - PID 5037 | |7;imaging-desaturate;99;96;94;94;94;94;94;99;95;94 09:17:13 INFO - PID 5037 | |8;json-parse-financial;54;55;55;57;56;57;61;56;56;55 09:17:13 INFO - PID 5037 | |9;json-stringify-tinderbox;56;56;55;55;55;54;55;56;56;56 09:17:13 INFO - PID 5037 | |10;stanford-crypto-aes;88;86;87;97;87;86;90;96;128;88 09:17:13 INFO - PID 5037 | |11;stanford-crypto-ccm;132;131;135;130;132;138;137;133;134;155 09:17:13 INFO - PID 5037 | |12;stanford-crypto-pbkdf2;186;203;199;197;189;205;200;211;209;212 09:17:13 INFO - PID 5037 | |13;stanford-crypto-sha256-iterative;73;72;80;72;71;72;71;72;70;75 09:17:13 INFO - PID 5037 | __end_tp_report 09:17:13 INFO - PID 5037 | __start_cc_report 09:17:13 INFO - PID 5037 | _x_x_mozilla_cycle_collect,1019 09:17:13 INFO - PID 5037 | __end_cc_report 09:17:13 INFO - PID 5037 | __startTimestamp1496420233054__endTimestamp 09:17:13 INFO - PID 5037 | 09:17:13 INFO - PID 5037 | ------- Summary: start ------- 09:17:13 INFO - PID 5037 | Number of tests: 14 09:17:13 INFO - PID 5037 | 09:17:13 INFO - PID 5037 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.50 stddev:2.80 (2.5%) stddev-sans-first:1.00 09:17:13 INFO - PID 5037 | Values: 102.0 112.0 110.0 111.0 110.0 111.0 109.0 111.0 109.0 110.0 09:17:13 INFO - PID 5037 | 09:17:13 INFO - PID 5037 | [#1] audio-beat-detection Cycles:10 Average:132.90 Median:126.50 stddev:16.92 (13.4%) stddev-sans-first:15.32 09:17:13 INFO - PID 5037 | Values: 158.0 126.0 122.0 165.0 122.0 121.0 121.0 121.0 146.0 127.0 09:17:13 INFO - PID 5037 | 09:17:13 INFO - PID 5037 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.50 stddev:2.88 (1.7%) stddev-sans-first:3.00 09:17:13 INFO - PID 5037 | Values: 164.0 165.0 164.0 163.0 163.0 170.0 169.0 169.0 166.0 162.0 09:17:13 INFO - PID 5037 | 09:17:13 INFO - PID 5037 | [#3] audio-fft Cycles:10 Average:79.70 Median:74.00 stddev:12.72 (17.2%) stddev-sans-first:13.26 09:17:13 INFO - PID 5037 | Values: 73.0 73.0 73.0 111.0 74.0 74.0 77.0 74.0 94.0 74.0 09:17:13 INFO - PID 5037 | 09:17:13 INFO - PID 5037 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:84.50 stddev:11.54 (13.7%) stddev-sans-first:12.12 09:17:13 INFO - PID 5037 | Values: 86.0 85.0 107.0 86.0 82.0 81.0 97.0 83.0 84.0 114.0 09:17:13 INFO - PID 5037 | 09:17:13 INFO - PID 5037 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:1.05 (0.9%) stddev-sans-first:1.12 09:17:13 INFO - PID 5037 | Values: 114.0 116.0 113.0 113.0 113.0 114.0 115.0 114.0 113.0 115.0 09:17:13 INFO - PID 5037 | 09:17:13 INFO - PID 5037 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 09:17:13 INFO - PID 5037 | Values: 151.0 152.0 150.0 151.0 152.0 151.0 150.0 150.0 151.0 152.0 09:17:13 INFO - PID 5037 | 09:17:13 INFO - PID 5037 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:94.50 stddev:2.06 (2.2%) stddev-sans-first:1.69 09:17:13 INFO - PID 5037 | Values: 99.0 96.0 94.0 94.0 94.0 94.0 94.0 99.0 95.0 94.0 09:17:13 INFO - PID 5037 | 09:17:13 INFO - PID 5037 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:1.93 (3.5%) stddev-sans-first:1.88 09:17:13 INFO - PID 5037 | Values: 54.0 55.0 55.0 57.0 56.0 57.0 61.0 56.0 56.0 55.0 09:17:13 INFO - PID 5037 | 09:17:13 INFO - PID 5037 | [#9] json-stringify-tinderbox Cycles:10 Average:55.40 Median:56.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 09:17:13 INFO - PID 5037 | Values: 56.0 56.0 55.0 55.0 55.0 54.0 55.0 56.0 56.0 56.0 09:17:13 INFO - PID 5037 | 09:17:13 INFO - PID 5037 | [#10] stanford-crypto-aes Cycles:10 Average:93.30 Median:88.00 stddev:12.82 (14.6%) stddev-sans-first:13.45 09:17:13 INFO - PID 5037 | Values: 88.0 86.0 87.0 97.0 87.0 86.0 90.0 96.0 128.0 88.0 09:17:13 INFO - PID 5037 | 09:17:13 INFO - PID 5037 | [#11] stanford-crypto-ccm Cycles:10 Average:135.70 Median:134.50 stddev:7.24 (5.4%) stddev-sans-first:7.56 09:17:13 INFO - PID 5037 | Values: 132.0 131.0 135.0 130.0 132.0 138.0 137.0 133.0 134.0 155.0 09:17:13 INFO - PID 5037 | 09:17:13 INFO - PID 5037 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:201.10 Median:204.00 stddev:8.79 (4.3%) stddev-sans-first:7.43 09:17:13 INFO - PID 5037 | Values: 186.0 203.0 199.0 197.0 189.0 205.0 200.0 211.0 209.0 212.0 09:17:13 INFO - PID 5037 | 09:17:13 INFO - PID 5037 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.80 Median:72.00 stddev:2.86 (4.0%) stddev-sans-first:3.03 09:17:13 INFO - PID 5037 | Values: 73.0 72.0 80.0 72.0 71.0 72.0 71.0 72.0 70.0 75.0 09:17:13 INFO - PID 5037 | -------- Summary: end -------- 09:17:13 INFO - PID 5037 | 09:17:14 INFO - TEST-INFO | 5037: exit 0 09:17:14 INFO - TEST-OK | kraken | took 91980ms 09:17:14 INFO - SUITE-END | took 1234s 09:17:14 INFO - Completed test suite (00:20:34) 09:17:14 INFO - javascript benchmark 09:17:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7621.781600703877, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3144.231678134159, 3145.98427007865, 3157.2106973256687, 3163.3673265346906, 3184.808911465312, 5908.704564771766, 5978.970105149474, 5979.192808970788, 5990.490808281291, 5998.82003539894, 5993.940060599392, 6008.639481631105, 6048.606840555361, 6110.938890611093, 6111.908321375183, 5456.8090116845915, 5554.86112847179, 5594.804181853616, 5624.95317533653, 5673.035583950738, 5662.490375866171, 5678.517326027292, 5684.346300175471, 5688.402717714643, 5704.087346024637, 5461.481159289861, 5522.806701765419, 5540.86147846303, 5595.0, 5609.102543593006, 5561.054620714488, 5597.552195824365, 5619.016672082369, 5635.154726790973, 5641.266635337421, 5555.055640541118, 5559.499645031967, 5567.220589117527, 5577.972110139464, 5586.441355864381, 5893.970530147321, 6022.69886505673, 6043.214382130339, 6043.607165534227, 6046.0326347784585, 6387.073874288202, 6413.903791443132, 6483.481321494269, 6497.1553698019425, 6532.314107018789, 6556.639384833832, 6569.868602627921, 6580.407763301326, 6586.637734924578, 6592.76925307612, 6039.365866584033, 6067.514598832083, 6068.059450785136, 6079.209702738615, 6087.421694938974, 6523.151990241238, 6584.967075164594, 6611.900821487681, 6688.197416310074, 6703.396694297537, 6139.768135342631, 6247.344028876993, 6270.905936410957, 6380.9361906380345, 6404.935950640527, 6366.076918846741, 6370.171877655967, 6467.191601049869, 6488.448481879093, 6492.967535162294, 6466.482681385478, 6506.804795856132, 6516.511261655395, 6517.674116294166, 6530.510211734139, 6318.6524741138755, 6406.743730250831, 6408.807735767934, 6541.247756507967, 6556.475481961527, 5331.893362132736, 5340.519353258225, 5368.8389348319615, 5370.167624018283, 5388.811391601275, 4545.250033744395, 4557.225271703818, 4561.29299958507, 4582.221022426195, 4667.883302917387, 5568.136938774496, 5704.771809127588, 5715.485606295453, 5721.170430287585, 5726.79956201531, 6371.0, 6410.967945160244, 6516.706748196342, 6525.184351956005, 6528.0, 5677.858053548612, 5702.0, 5708.086706127, 5714.257146570919, 5739.0, 5785.82642520725, 5791.739371728282, 5795.82612521625, 5796.913046304308, 5807.593468457252, 6113.871604717271, 6203.96898015516, 6227.408396202444, 6310.558260921692, 6327.240731112296, 6520.967395163184, 6578.8355291118105, 6580.144581204604, 6600.867982640416, 6608.074869518176, 6290.150829637941, 6384.170057892445, 6401.77593784234, 6405.263394709482, 6420.582662126947, 6234.064890266496, 6295.748170073146, 6303.621782693053, 6416.711247993945, 6433.710483028369, 6550.148480697479, 6550.737970481127, 6558.967205163944, 6560.671966401756, 6588.505862060269, 6149.41580549847, 6335.714892829926, 6342.556021078481, 6350.079238510482, 6372.426481616677, 6153.938460615336, 6251.874962500816, 6284.434400903758, 6326.114343991937, 6345.302016778243, 6091.8781624366375, 6189.071639254148, 6284.811455656338, 6307.810765677037, 6308.369163083655, 6312.43188113072, 6331.841703957438, 6369.33122022181, 6392.68036598159, 6408.679566021587, 6179.721912513858, 6218.284897236876, 6233.376662333731, 6239.625622462485, 6242.1261023455845], "value": 5942.835317106243, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.1105146195911, 757.526545908807, 774.9457537972343, 986.0336869867525, 987.2250283527433, 35318.0, 36645.26709465813, 36688.08279793007, 36706.0, 36718.63281367186, 39063.609363906355, 39426.0, 39457.21085578287, 39519.802400988025, 39574.80212598933, 7238.1314242291, 7398.6670599823, 7407.0, 7534.547927124363, 7543.849123017536, 7397.224666080156, 7401.555906645592, 7481.5885126318035, 7481.6259187040705, 7508.774736757906, 7424.294692004251, 7483.663235154404, 7493.063367079115, 7493.625318734069, 7514.361279291239, 7435.405167586607, 7436.40508759298, 7470.140933792629, 7472.215417381179, 7498.887516687254, 7328.413726901835, 7345.88981165283, 7402.925970740277, 7403.1486379066555, 7404.96297518509, 34915.0, 35023.4746478803, 35117.824410878035, 35194.29611407783, 35215.1196220094, 3439.3809114359406, 3474.0, 3474.2877710069374, 3475.0617333320115, 3476.530668359764, 27586.172414827586, 27662.861685691645, 27688.0, 27758.44483110347, 27791.444171116465, 3551.183227857607, 3552.182997910495, 3557.8576856925692, 3560.5549306336707, 3585.085803120188, 134654.0, 137416.0, 150291.24854375768, 163669.0, 165559.0, 42794.572054279684, 42818.57181428146, 42836.35745463821, 42958.78520607377, 43051.56948430475, 44833.32750008752, 45081.32378014332, 45218.32172517415, 45355.09289814251, 45403.772981135546, 14542.418303267963, 14609.488667896572, 14612.342444590018, 14663.19352435605, 14683.0, 11916.603767926099, 11928.0, 11928.34394108315, 12003.699907502207, 12044.51821927113, 13707.177569345871, 13782.93108534451, 13870.930645346709, 13886.0, 13986.230757308242, 5516.558675306046, 5601.971990140023, 5692.097030514467, 5805.970970145122, 5900.970495147497, 951.6145960885852, 1008.969730908074, 1010.7523656704008, 1013.5337744637402, 1046.4715318763976, 23397.649035264483, 23872.28383148508, 23886.64170037451, 23890.163844265713, 24094.39764005879, 1095.2114477576133, 1097.632293181793, 1101.0475938313302, 1101.300674071954, 1105.5964572930823, 12526.74946501065, 12635.74728505443, 12636.368181590884, 12645.367731613567, 12808.80786788199, 204342.0, 205075.0, 206184.0, 206268.0, 206758.0, 49079.26381104286, 49228.26157607639, 49713.751431243334, 49826.750866245435, 49936.99999999927, 1374.924379159156, 1414.1444426122255, 1427.2435609127178, 1436.1454934314067, 1437.9856201437851, 22458.326250212518, 22851.657225141305, 23715.169969051, 23791.074472712502, 23796.286111416684, 36023.45964810478, 36178.0, 36271.274574507835, 36413.27173456569, 36424.45363319499, 179296.0, 179631.10184448995, 180104.0, 180578.0, 181129.0, 31938.520922185722, 32195.20486312486, 33444.0, 33677.831610841786, 33736.83131584425, 41085.0, 41217.793911030254, 42137.0, 42734.5726542743, 42827.0, 30230.395392092476, 30333.544996825505, 30627.846860765552, 30993.8450307747, 31437.842810785798, 28852.278693032844, 29709.0, 29843.701562984093, 31192.532112017885, 31411.685883140875, 33888.0, 33910.66089339075, 34179.48730768991, 34185.82907085449, 34220.0, 28469.43061138724, 29443.558346625246, 29546.704532954394, 29812.807487700247, 31134.532982004836, 23077.307680769605, 24142.39644008914, 24260.1508947186, 24336.148234812405, 24358.0], "value": 16144.971631049675, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.0732018839308, 430.9396684464174, 436.7008599109609, 442.28350072881926, 445.75037978731893, 10840.512176952036, 11252.38111903847, 20410.285640002603, 21267.36197914063, 21363.57272854542, 21647.242346517876, 22462.0, 22508.8874555627, 22545.0, 22558.88720556399, 5886.087656413263, 6050.334463209044, 6051.636901785907, 6064.4541991220785, 6064.757409703607, 5901.675407852566, 5957.344692083867, 5976.462118409342, 5982.4316689914385, 6038.667873266969, 5662.745176467049, 5894.233749612545, 5942.5840191186635, 5952.987992041341, 5985.910211346833, 5909.911351329733, 5915.319738230116, 5935.258092738408, 5981.790637327695, 5983.282006159246, 5337.11937530307, 5369.463053694639, 5371.140617501181, 5375.569954403638, 5388.248819133797, 24681.136160234484, 24784.158455439436, 24788.25635230928, 25064.87467562669, 25166.874165629237, 1898.8765730227492, 1919.606480671459, 1923.8749481283812, 1925.1433112265047, 1932.7390802241657, 16186.190690465548, 16925.153742312836, 16966.151692415453, 16975.830241697673, 17019.063951482665, 2143.239150101707, 2171.4354267890462, 2207.1061220205843, 2217.279384200125, 2222.122261706633, 116793.23291355644, 118035.40982295033, 118962.0, 119154.0, 119289.0, 11042.227044106996, 11472.885271147348, 11633.59282425111, 11639.243449175776, 12147.210431321935, 16574.502764917073, 16592.0, 16600.750988735177, 16606.916965415097, 16699.91650041742, 8033.433480471252, 8091.595420228965, 8144.755657330171, 8148.185181481923, 8223.136570659995, 7470.3276705096805, 7543.0, 7560.3573696236435, 7685.42359323053, 7690.846183076307, 7608.429367797437, 7643.235676432312, 7659.961700191463, 7708.460407771514, 7725.768226953201, 2117.6294148524253, 2117.723447294165, 2178.5533965537343, 2194.813440857545, 2205.3163519309064, 933.3653115881266, 969.4328817641617, 970.8737864077766, 998.6554638649654, 1015.9085682288629, 18902.621947560972, 19032.238710451427, 19663.0, 19731.210751570063, 19979.800201997794, 1002.8545860850281, 1019.6023550815188, 1024.6260115058099, 1027.4913917610832, 1031.4481752262504, 10414.947925260325, 10713.35719856811, 10760.3543787373, 10799.83800242997, 10873.130149588173, 437193.0, 442338.0, 450998.0, 455143.0, 455158.0, 95201.0, 95794.0, 96002.0, 100172.4991375053, 103220.0, 1160.3154139057997, 1175.1362748379934, 1177.0289511153333, 1180.144395313391, 1185.229600759496, 16440.83559164441, 16593.585160370603, 17111.57221069483, 17168.656626867643, 17172.484825455256, 45182.32226516539, 46161.230326180535, 46763.766181168874, 46876.29685554651, 47329.76335118302, 58619.70690146522, 58877.70561147167, 59105.70447147909, 59204.40795591989, 65608.0, 9499.240060795259, 9725.319227653996, 9732.659356922473, 9755.170810481188, 9770.0, 15776.68446631038, 15872.92063539675, 16037.919810400874, 16108.355665773237, 16378.672426551164, 13257.66855828612, 13432.126911750705, 13706.177629342272, 13816.792748108586, 14187.929060354632, 11883.346415947206, 12149.878501214875, 12491.687707807378, 12882.911250056362, 13739.313034348042, 12902.225866448043, 13150.934245328712, 13263.469461221443, 13433.059685821898, 13598.524051658145, 9205.30960177976, 9384.765380865532, 9433.528323583656, 9517.762055948657, 9595.0, 13861.306934653428, 13989.23059231752, 14117.929410352883, 14258.0, 14480.34838432252], "value": 10032.416215277482, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1296.2416986063154, 1351.6350585341959, 1366.8906487481001, 1370.198433916159, 1370.4038743146739, 10761.730956726085, 10915.836262456069, 11190.0, 11237.101031917458, 11353.545858165684, 10811.78376432471, 11002.944985275082, 11003.0, 11033.337999720003, 11035.062019728333, 2369.1115831563206, 2408.4460574067975, 2408.4580969281947, 2409.084547871806, 2412.360724408033, 2335.5795956727784, 2383.940401489959, 2390.940226494334, 2391.2467572714627, 2394.892229849661, 2304.72343318802, 2317.8493397929165, 2319.7100362454694, 2329.2662811214414, 2335.789778919897, 2228.765979572154, 2264.19621034532, 2270.2167752125492, 2277.533105713325, 2282.7260728712495, 2210.6794514795424, 2246.618074927266, 2317.165820304689, 2320.3619004773655, 2327.1622216002224, 10906.072983796386, 11038.17213708967, 11053.502592383362, 11081.612143575017, 11086.057685096777, 6106.816795496142, 6311.337309582474, 6321.810345689591, 6354.2692590352235, 6357.268914074848, 3466.324066806974, 3643.890683279506, 3721.0511319613324, 3726.31063253299, 3754.868579599728, 1225.9019278457702, 1232.3961258983124, 1257.8553466351395, 1272.6372983699694, 1280.590211132438, 15720.0, 15813.130277834714, 15864.36542538297, 15952.680946381124, 16359.754603681073, 5111.284420181178, 5151.2530683050745, 5261.76322065508, 5297.735113244399, 5334.386545547234, 11578.131640126856, 11585.189036767346, 11697.883021169679, 11719.12106592009, 11720.120990925714, 6116.449519543263, 6210.627362358273, 6233.283172435137, 6245.656488893063, 6256.249250090018, 5761.337446193657, 5831.825045248649, 5848.152017957373, 5863.560232982543, 5873.765049398062, 4118.83761025464, 4148.688848336386, 4158.875233742992, 4174.432723874856, 4216.439917230644, 1197.700574856286, 1206.7827790997706, 1225.8467691538558, 1237.4408245610596, 1250.46230121047, 837.4891316297054, 840.3445312656138, 848.6605357856783, 871.1071152069053, 891.741394995444, 6186.412290832363, 6209.565330426827, 6231.968840155861, 6241.282252540925, 6424.164858568356, 619.0744836469507, 622.5673157155733, 628.8805127025851, 644.5294934697697, 646.6508085633799, 4116.382542618631, 4346.456692913386, 4559.224931761609, 4596.724196548218, 4629.791659375336, 14037.0, 14510.492132775302, 14562.927185364217, 14589.85410145885, 14611.707765844623, 13468.191908485522, 14008.369623366973, 14045.85954140466, 14076.225807580682, 14190.716185676229, 7166.104236970379, 8385.874211886827, 8636.17956294151, 8659.523726194993, 8667.0, 5816.9127463088935, 6696.497762667722, 6887.139107611549, 7152.177499587614, 7196.856062878818, 12035.939820300842, 12137.21108127969, 12368.072394570623, 12389.75220495603, 12392.81410778857, 12122.636320910387, 12171.634850954486, 12199.878001219875, 12300.876991229974, 12382.380880956096, 9294.25645948336, 9567.952160239154, 9570.234381249344, 9576.138147566473, 9665.033496650278, 10591.364518128938, 10746.355218686904, 10755.193360497837, 10763.784724305313, 10786.137109031102, 8889.333300002396, 8891.066438023914, 8957.776055598662, 9181.403208791407, 9338.486383248986, 8587.742367728979, 8640.697575584825, 8675.696350627697, 8862.822743544964, 8937.508437036025, 7576.696932122653, 7581.431392645463, 7651.617419129133, 7672.80817979555, 7698.153203147761, 5905.822825315247, 5912.320083190488, 5938.910916336345, 5957.314908785545, 6081.27024757032, 5498.120300751861, 5561.8609534760335, 5606.467385598362, 5665.923474539824, 5804.0], "value": 5121.2414415068015, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.68213042109835, 394.9328614135597, 399.60638770810766, 401.7950845069014, 401.8472980267498, 6005.849853753658, 6193.801200573799, 6200.782972595955, 6201.441870231678, 6212.689365531728, 5934.287885453741, 5936.732847021884, 6009.188759517464, 6016.60892042017, 6042.728077236524, 4721.504242054586, 4742.454617718955, 4744.0, 4745.0, 4745.406824146981, 4541.977290113561, 4737.834175803848, 4755.690880092783, 4758.119747846642, 4760.666753327268, 4658.976705116486, 4665.813367465297, 4672.135654903836, 4675.696079754805, 4687.992081702433, 4658.1848176568965, 4676.36869022681, 4687.601553867926, 4694.319323698061, 4700.459447163552, 4109.321961876287, 4154.771487568182, 4155.563665815106, 4158.750474971481, 4161.500619925629, 5876.324222714357, 6001.729922153513, 6009.519238460956, 6018.518518518508, 6023.186869772569, 5349.0, 5371.328583927009, 5377.0, 5402.540784033323, 5402.621816472849, 6361.80914572559, 6368.089573128043, 6436.163298771176, 6441.774537891151, 6456.2575303840185, 4520.367148599199, 4532.184206842767, 4535.433070866142, 4540.250858608326, 4542.659300552472, 6459.450946669539, 6471.223453185601, 6623.834404139887, 6754.155730533684, 6831.146106736658, 4598.666386747873, 4604.102200070954, 4616.676832621684, 4623.976880115645, 4636.884077898012, 4659.347691323217, 4677.742724150136, 4696.272077827942, 4696.976515117471, 4717.646176536773, 5329.786808527693, 5341.866453338697, 5361.383440904268, 5373.9731301343245, 5392.91910621341, 6428.453581445536, 6434.131392262078, 6443.742250309935, 6444.581102228434, 6448.322926092693, 1612.0, 1627.3246602660001, 1628.2265923686155, 1630.1115891838976, 1632.583691158747, 1013.2198207380276, 1084.9186311026704, 1089.4008295437477, 1104.4864138175788, 1107.1419649771492, 5787.536997040227, 5788.21859049023, 5809.157672137517, 5809.838032393538, 5817.127430885401, 6626.445851729033, 6645.5411497746145, 6648.368405001517, 6652.234992975869, 6653.234877989094, 5719.7426115824055, 5728.882867840731, 5776.364599894008, 5793.594448388572, 5797.376734514342, 3495.0563347895927, 3537.982310088433, 3549.396602577568, 3550.627184145679, 3560.359135355661, 6437.935620643733, 6445.677716114175, 6447.903281450782, 6473.320301368382, 6487.902681459782, 6735.29279425663, 6750.173625857536, 6773.983902414579, 6787.524873258923, 6807.455403567802, 6401.3278605746655, 6408.58344207625, 6453.290138084713, 6457.806265811939, 6467.51493637979, 6565.80302590923, 6592.670366481752, 6636.203655561363, 6639.900401494078, 6661.933380666325, 6539.901901471387, 6561.639109849004, 6584.432071492026, 6594.868102638016, 6600.966995164993, 6025.517958563392, 6386.552941294065, 6394.232692076795, 6450.741970321134, 6502.512311576746, 4604.332371806003, 4608.792604332746, 4618.353430519663, 4619.653525985632, 4636.721796692209, 6366.872662546631, 6608.273089960197, 6623.807714611224, 6716.664166791543, 6720.991851222356, 6413.775517856852, 6421.0, 6425.58233714807, 6451.3226111257645, 6474.352564743488, 6441.742330306735, 6456.903146452713, 6477.935220647922, 6486.610803351814, 6497.512686548623, 6328.272248691459, 6332.398422149889, 6339.96830015847, 6357.364263573606, 6396.872062558629, 6448.0, 6470.094186813756, 6484.870302593828, 6488.643124628191, 6510.381513756186, 6244.843878903063, 6283.905741413974, 6305.842353941188, 6311.2426508819235, 6317.210348706411], "value": 4850.241007365159, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [792.4096548071687, 815.2581151152452, 821.4947807098634, 830.9210624990624, 831.9625616847242, 16703.248353824078, 17291.91354043228, 17314.134293285333, 17765.91117044413, 19770.90114549429, 16736.83263167368, 16923.3230670773, 17144.742828857576, 17326.740098898495, 17338.739918901225, 965.859950307205, 988.6737376665683, 996.1433167475965, 997.990020099797, 1000.9899901001006, 965.478641533571, 1000.049952545085, 1001.529281237817, 1004.7638804880847, 1010.3634710132607, 1058.978820423591, 1059.533805125746, 1060.2154405739775, 1060.2631171335925, 1062.0123285344664, 1049.8162821506244, 1057.8889216632297, 1058.4443167337172, 1058.8888166742497, 1060.7560261139904, 765.8085478630343, 765.9693612255503, 768.1243382543904, 770.9845803083907, 773.872311068673, 16229.188540573043, 16830.24263908115, 17390.21744021522, 17516.824831751648, 17548.29806807739, 18507.722384164248, 18628.534286642807, 18694.06529673511, 18734.0, 18915.14881830321, 15110.471133510384, 15237.695246095016, 15380.0, 15397.615059623487, 15440.536783896501, 3297.851596678155, 3334.4498157803932, 3348.665133486656, 3438.9828050859837, 3476.600190978045, 82344.0, 84885.0, 84955.15044849472, 84996.0, 85152.0, 14294.428222871176, 15263.465778697915, 15608.687826243411, 15708.21458927049, 15722.13528255934, 24919.501609967698, 25643.230703078938, 25707.74292257091, 25904.481910362065, 25928.0, 8053.557054362066, 8084.312833409226, 8538.658453661908, 8551.572421378905, 8587.87118193215, 3995.4006898965386, 4071.572484889103, 4074.7351422157467, 4075.612816782401, 4085.366768150882, 4104.856330028435, 4124.608162224584, 4127.938080928789, 4132.628063474302, 4331.198728235287, 839.8404303182498, 855.1405837133765, 862.3273846399818, 869.4044579463088, 869.7347309070794, 673.1417442760421, 677.7695583501535, 704.7181127548919, 705.3405066262958, 707.2609123465991, 10901.727456813644, 11268.605598804166, 11815.05479561633, 11982.580609678795, 12396.442160102817, 670.4569298867932, 688.4114082459525, 703.1421665567999, 707.3386383731125, 713.3829237709344, 5226.5818734501145, 5321.600879934021, 5494.697791621499, 5572.554195664337, 5654.74553645087, 88538.55730721305, 88969.0, 89117.0, 89918.55040724755, 91966.54016729874, 81632.0, 82743.58628206821, 82914.58542707248, 83483.5825820867, 83561.0, 70542.0, 70591.0, 71206.64396678087, 71618.0, 73171.16715018927, 10836.783264334512, 11376.317420954769, 11537.538498459968, 11538.538458461568, 11634.185607007428, 30404.5439318406, 30587.2353191172, 30867.228319292197, 30953.535696964114, 31594.36811263716, 38770.61229387783, 38881.0, 38967.415488767125, 39236.60763392444, 39563.0, 14661.266936653337, 14854.554363369116, 15112.319945602694, 15206.391744330103, 15369.923150384177, 18337.816621833612, 19028.238870445028, 19150.616987660447, 19389.51526211856, 19418.223271069, 15796.92101539485, 16952.830471695124, 17126.0, 17261.223244954257, 17397.652046958738, 17047.147642617572, 17546.73679894828, 17804.10979451048, 17841.553961151076, 17867.106644667976, 16887.07121108351, 17280.04959727227, 17370.39203627867, 17718.0, 17755.733663994793, 11859.0, 11931.582394616147, 12192.634220973385, 12342.259464432163, 12405.069619778733, 12202.633920982385, 13752.868691975784, 13783.862161378258, 14190.574282771533, 14198.219097949712], "value": 8198.515371827058, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 110.0, 111.0, 110.0, 111.0, 109.0, 111.0, 109.0, 110.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 126.0, 122.0, 165.0, 122.0, 121.0, 121.0, 121.0, 146.0, 127.0], "value": 132.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 164.0, 163.0, 163.0, 170.0, 169.0, 169.0, 166.0, 162.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 73.0, 111.0, 74.0, 74.0, 77.0, 74.0, 94.0, 74.0], "value": 79.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 107.0, 86.0, 82.0, 81.0, 97.0, 83.0, 84.0, 114.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 113.0, 113.0, 113.0, 114.0, 115.0, 114.0, 113.0, 115.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 150.0, 151.0, 152.0, 151.0, 150.0, 150.0, 151.0, 152.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 96.0, 94.0, 94.0, 94.0, 94.0, 94.0, 99.0, 95.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 57.0, 56.0, 57.0, 61.0, 56.0, 56.0, 55.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 55.0, 55.0, 54.0, 55.0, 56.0, 56.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 87.0, 97.0, 87.0, 86.0, 90.0, 96.0, 128.0, 88.0], "value": 93.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 131.0, 135.0, 130.0, 132.0, 138.0, 137.0, 133.0, 134.0, 155.0], "value": 135.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 203.0, 199.0, 197.0, 189.0, 205.0, 200.0, 211.0, 209.0, 212.0], "value": 201.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 80.0, 72.0, 71.0, 72.0, 71.0, 72.0, 70.0, 75.0], "value": 72.8, "unit": "score"}]}]} 09:17:14 INFO - Return code: 0 09:17:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:17:14 INFO - # TBPL SUCCESS # 09:17:14 INFO - Running post-action listener: _resource_record_post_action 09:17:14 INFO - [mozharness: 2017-06-02 16:17:14.421449Z] Finished run-tests step (success) 09:17:14 INFO - Running post-run listener: _resource_record_post_run 09:17:14 INFO - Total resource usage - Wall time: 1252s; CPU: 13.0%; Read bytes: 425984; Write bytes: 437022720; Read time: 64; Write time: 300964 09:17:14 INFO - TinderboxPrint: CPU usage
12.6% 09:17:14 INFO - TinderboxPrint: I/O read bytes / time
425,984 / 64 09:17:14 INFO - TinderboxPrint: I/O write bytes / time
437,022,720 / 300,964 09:17:14 INFO - TinderboxPrint: CPU idle
8,727.2 (87.3%) 09:17:14 INFO - TinderboxPrint: CPU user
1,211.1 (12.1%) 09:17:14 INFO - TinderboxPrint: Swap in / out
0 / 0 09:17:14 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 113938432; Read time: 0; Write time: 90428 09:17:14 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:17:14 INFO - run-tests - Wall time: 1235s; CPU: 13.0%; Read bytes: 421888; Write bytes: 323084288; Read time: 48; Write time: 210536 09:17:15 INFO - Running post-run listener: _upload_blobber_files 09:17:15 INFO - Blob upload gear active. 09:17:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:17:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:17:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:17:15 INFO - (blobuploader) - INFO - Open directory for files ... 09:17:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:17:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:17:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:17 INFO - (blobuploader) - INFO - Done attempting. 09:17:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:17:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:17:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:17 INFO - (blobuploader) - INFO - Done attempting. 09:17:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:17:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:17:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:18 INFO - (blobuploader) - INFO - Done attempting. 09:17:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:17:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:17:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:24 INFO - (blobuploader) - INFO - Done attempting. 09:17:24 INFO - (blobuploader) - INFO - Iteration through files over. 09:17:24 INFO - Return code: 0 09:17:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:17:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:17:24 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df165ed349a4a372911ebd27a4d382d43a5bbd7ca5882a5543517515c1509bd140736d4fbdf7c2304f96550c71cdf2dde3b52d028c7fd651effc84c19fd294d3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d54c9542c849dfc4393b340df5890d50693bf0eaffbd03f44980b139e54143d47ffdf88089d910456eb8d1058048955cdb9e5159479b7dfee70a90cae9f271d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac42ec5f7b83d6c5a47204a501f06c85d34be1cafde90372c49cc9b3539fb3000133af7f1457154c6809640be557f6993ec9a6a503630a4f828caac2db482c38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e6c736f5e8ae2e19444c55dfa45c8c8c5bffc2092ace0806a0dfe2e77c7255569dff4020cd5e89fcac95ea334afa4e4e41b52c9b581342911959ff75cd9a9b09"} 09:17:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:17:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:17:24 INFO - Contents: 09:17:24 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df165ed349a4a372911ebd27a4d382d43a5bbd7ca5882a5543517515c1509bd140736d4fbdf7c2304f96550c71cdf2dde3b52d028c7fd651effc84c19fd294d3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d54c9542c849dfc4393b340df5890d50693bf0eaffbd03f44980b139e54143d47ffdf88089d910456eb8d1058048955cdb9e5159479b7dfee70a90cae9f271d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac42ec5f7b83d6c5a47204a501f06c85d34be1cafde90372c49cc9b3539fb3000133af7f1457154c6809640be557f6993ec9a6a503630a4f828caac2db482c38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e6c736f5e8ae2e19444c55dfa45c8c8c5bffc2092ace0806a0dfe2e77c7255569dff4020cd5e89fcac95ea334afa4e4e41b52c9b581342911959ff75cd9a9b09"} 09:17:24 INFO - Running post-run listener: copy_logs_to_upload_dir 09:17:24 INFO - Copying logs to upload dir... 09:17:24 INFO - mkdir: /builds/slave/test/build/upload/logs 09:17:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1315.676872 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 55 secs) (at 2017-06-02 09:17:24.197014) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-02 09:17:24.200771) ========= 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=3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df165ed349a4a372911ebd27a4d382d43a5bbd7ca5882a5543517515c1509bd140736d4fbdf7c2304f96550c71cdf2dde3b52d028c7fd651effc84c19fd294d3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d54c9542c849dfc4393b340df5890d50693bf0eaffbd03f44980b139e54143d47ffdf88089d910456eb8d1058048955cdb9e5159479b7dfee70a90cae9f271d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac42ec5f7b83d6c5a47204a501f06c85d34be1cafde90372c49cc9b3539fb3000133af7f1457154c6809640be557f6993ec9a6a503630a4f828caac2db482c38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e6c736f5e8ae2e19444c55dfa45c8c8c5bffc2092ace0806a0dfe2e77c7255569dff4020cd5e89fcac95ea334afa4e4e41b52c9b581342911959ff75cd9a9b09"} build_url:https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011342 build_url: 'https://queue.taskcluster.net/v1/task/E0vr8iksQx6TXHW5XHPIvQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/df165ed349a4a372911ebd27a4d382d43a5bbd7ca5882a5543517515c1509bd140736d4fbdf7c2304f96550c71cdf2dde3b52d028c7fd651effc84c19fd294d3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0d54c9542c849dfc4393b340df5890d50693bf0eaffbd03f44980b139e54143d47ffdf88089d910456eb8d1058048955cdb9e5159479b7dfee70a90cae9f271d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac42ec5f7b83d6c5a47204a501f06c85d34be1cafde90372c49cc9b3539fb3000133af7f1457154c6809640be557f6993ec9a6a503630a4f828caac2db482c38", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e6c736f5e8ae2e19444c55dfa45c8c8c5bffc2092ace0806a0dfe2e77c7255569dff4020cd5e89fcac95ea334afa4e4e41b52c9b581342911959ff75cd9a9b09"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-02 09:17:24.225080) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 09:17:24.225428) ========= 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=3297cc2eebb5444a7688c33f000001b5-1496416942.82106-1953273457 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-02 09:17:24.310195) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-02 09:17:24.310512) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-02 09:17:24.310805) ========= ========= Total master_lag: 0.16 =========