builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-042 starttime: 1496370695.12 results: success (0) revision: aeb3d0ca558f034cbef1c5a68bd07dd738611494 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:35.115577) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:35.116077) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:35.116380) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:35.157191) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:35.157620) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-01 19:31:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.9M=0s 2017-06-01 19:31:35 (42.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.238419 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:35.439350) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:35.439728) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.051945 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:35.504498) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:35.505005) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev aeb3d0ca558f034cbef1c5a68bd07dd738611494 --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 aeb3d0ca558f034cbef1c5a68bd07dd738611494 --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=74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-01 19:31:35,702 truncating revision to first 12 chars 2017-06-01 19:31:35,702 Setting DEBUG logging. 2017-06-01 19:31:35,702 attempt 1/10 2017-06-01 19:31:35,702 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/aeb3d0ca558f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-01 19:31:36,021 unpacking tar archive at: mozilla-central-aeb3d0ca558f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.734261 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:36.254420) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:36.254970) ========= script_repo_revision: aeb3d0ca558f034cbef1c5a68bd07dd738611494 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:36.255606) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:36.256025) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-01 19:31:36.266066) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2017-06-01 19:31:36.266504) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:31:36 INFO - MultiFileLogger online at 20170601 19:31:36 in /builds/slave/test 19:31:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 19:31:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:31:36 INFO - {'append_to_log': False, 19:31:36 INFO - 'base_work_dir': '/builds/slave/test', 19:31:36 INFO - 'blob_upload_branch': 'Firefox', 19:31:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:31:36 INFO - 'branch': 'Firefox', 19:31:36 INFO - 'buildbot_json_path': 'buildprops.json', 19:31:36 INFO - 'config_files': ('talos/linux_config.py',), 19:31:36 INFO - 'default_actions': ('clobber', 19:31:36 INFO - 'read-buildbot-config', 19:31:36 INFO - 'download-and-extract', 19:31:36 INFO - 'populate-webroot', 19:31:36 INFO - 'create-virtualenv', 19:31:36 INFO - 'install', 19:31:36 INFO - 'setup-mitmproxy', 19:31:36 INFO - 'run-tests'), 19:31:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:31:36 INFO - 'download_minidump_stackwalk': True, 19:31:36 INFO - 'download_symbols': 'ondemand', 19:31:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:31:36 INFO - 'tooltool.py': '/tools/tooltool.py', 19:31:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:31:36 INFO - '/tools/misc-python/virtualenv.py')}, 19:31:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:31:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:31:36 INFO - 'gecko_profile': False, 19:31:36 INFO - 'gecko_profile_interval': 0, 19:31:36 INFO - 'installer_path': 'installer.exe', 19:31:36 INFO - 'log_level': 'info', 19:31:36 INFO - 'log_name': 'talos', 19:31:36 INFO - 'log_to_console': True, 19:31:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:31:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:31:36 INFO - 'opt_config_files': (), 19:31:36 INFO - 'pip_index': False, 19:31:36 INFO - 'suite': 'dromaeojs-e10s', 19:31:36 INFO - 'system_bits': '32', 19:31:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:31:36 INFO - 'title': 'talos-linux64-ix-042', 19:31:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:31:36 INFO - 'use_talos_json': True, 19:31:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:31:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:31:36 INFO - 'work_dir': 'build'} 19:31:36 INFO - [mozharness: 2017-06-02 02:31:36.693208Z] Running clobber step. 19:31:36 INFO - Running pre-action listener: _resource_record_pre_action 19:31:36 INFO - Running main action method: clobber 19:31:36 INFO - rmtree: /builds/slave/test/build 19:31:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:31:38 INFO - Running post-action listener: _resource_record_post_action 19:31:38 INFO - [mozharness: 2017-06-02 02:31:38.766944Z] Finished clobber step (success) 19:31:38 INFO - [mozharness: 2017-06-02 02:31:38.767046Z] Running read-buildbot-config step. 19:31:38 INFO - Running pre-action listener: _resource_record_pre_action 19:31:38 INFO - Running main action method: read_buildbot_config 19:31:38 INFO - Using buildbot properties: 19:31:38 INFO - { 19:31:38 INFO - "project": "", 19:31:38 INFO - "product": "firefox", 19:31:38 INFO - "who": "kwierso@gmail.com", 19:31:38 INFO - "installer_path": "public/build/target.tar.bz2", 19:31:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 19:31:38 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 19:31:38 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 19:31:38 INFO - "stage_platform": "linux64-stylosequential", 19:31:38 INFO - "basedir": "/builds/slave/test", 19:31:38 INFO - "buildnumber": 37, 19:31:38 INFO - "platform": "ubuntu64_hw_styloseq", 19:31:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:31:38 INFO - "slavebuilddir": "test", 19:31:38 INFO - "taskId": "asPlIj8HQ5GZX_jAKeLu8A", 19:31:38 INFO - "branch": "mozilla-central", 19:31:38 INFO - "script_repo_revision": "production", 19:31:38 INFO - "revision": "aeb3d0ca558f034cbef1c5a68bd07dd738611494", 19:31:38 INFO - "slavename": "talos-linux64-ix-042", 19:31:38 INFO - "repo_path": "mozilla-central" 19:31:38 INFO - } 19:31:38 INFO - Finding installer, test and symbols from parent task. 19:31:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/asPlIj8HQ5GZX_jAKeLu8A'}, attempt #1 19:31:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/asPlIj8HQ5GZX_jAKeLu8A'}, attempt #1 19:31:39 INFO - Task dependencies: Iq4sCn0zRVu1rgKF7Vu6yg 19:31:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg'}, attempt #1 19:31:40 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.tar.bz2 19:31:40 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/test_packages.json 19:31:40 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.crashreporter-symbols.zip 19:31:40 INFO - Running post-action listener: _resource_record_post_action 19:31:40 INFO - [mozharness: 2017-06-02 02:31:40.116399Z] Finished read-buildbot-config step (success) 19:31:40 INFO - [mozharness: 2017-06-02 02:31:40.116619Z] Running download-and-extract step. 19:31:40 INFO - Running pre-action listener: _resource_record_pre_action 19:31:40 INFO - Running main action method: download_and_extract 19:31:40 INFO - mkdir: /builds/slave/test/build/tests 19:31:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:31:40 INFO - trying https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.test_packages.json 19:31:40 INFO - Downloading https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:31:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:31:40 INFO - Downloaded 986 bytes. 19:31:40 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:31:40 INFO - Using the following test package requirements: 19:31:40 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 19:31:40 INFO - u'common': [u'target.common.tests.zip'], 19:31:40 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:31:40 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:31:40 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:31:40 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:31:40 INFO - u'mozbase': [u'target.common.tests.zip'], 19:31:40 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:31:40 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:31:40 INFO - u'web-platform': [u'target.common.tests.zip', 19:31:40 INFO - u'target.web-platform.tests.zip'], 19:31:40 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:31:40 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:31:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.common.tests.zip 19:31:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:31:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.common.tests.zip into memory 19:31:42 INFO - Content-Length response header: 63544019 19:31:42 INFO - Bytes received: 63544019 19:31:53 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:31:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.common.tests.zip 19:31:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:31:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.common.tests.zip into memory 19:31:54 INFO - Content-Length response header: 63544019 19:31:54 INFO - Bytes received: 63544019 19:32:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.talos.tests.zip 19:32:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:32:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.talos.tests.zip into memory 19:32:07 INFO - Content-Length response header: 14447425 19:32:07 INFO - Bytes received: 14447425 19:32: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')]} 19:32:07 INFO - trying https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.tar.bz2 19:32:07 INFO - Downloading https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:32:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:32:09 INFO - Downloaded 55954854 bytes. 19:32:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.tar.bz2 19:32:09 INFO - mkdir: /builds/slave/test/properties 19:32:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:32:09 INFO - Writing to file /builds/slave/test/properties/build_url 19:32:09 INFO - Contents: 19:32:09 INFO - build_url:https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.tar.bz2 19:32:09 INFO - Running post-action listener: _resource_record_post_action 19:32:09 INFO - Running post-action listener: set_extra_try_arguments 19:32:09 INFO - [mozharness: 2017-06-02 02:32:09.373361Z] Finished download-and-extract step (success) 19:32:09 INFO - [mozharness: 2017-06-02 02:32:09.373480Z] Running populate-webroot step. 19:32:09 INFO - Running pre-action listener: _resource_record_pre_action 19:32:09 INFO - Running main action method: populate_webroot 19:32:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:32:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:32:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:32:09 INFO - '--tppagecycles', 19:32:09 INFO - '7'], 19:32:09 INFO - 'tests': ['tsvgm']}}, 19:32:09 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:32:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:32:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:32:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:32:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:32:09 INFO - 'talos_options': ['--disable-e10s'], 19:32:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:32:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:32:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:32:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:32:09 INFO - 'talos_options': ['--disable-e10s'], 19:32:09 INFO - 'tests': ['damp', 'tps']}, 19:32:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:32:09 INFO - 'tests': ['damp', 'tps']}, 19:32:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:32:09 INFO - 'tests': ['dromaeo_dom']}, 19:32:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:32:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:32:09 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 19:32:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 19:32:09 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 19:32:09 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 19:32:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:32:09 INFO - 'tests': ['a11yr', 19:32:09 INFO - 'ts_paint', 19:32:09 INFO - 'tpaint', 19:32:09 INFO - 'sessionrestore', 19:32:09 INFO - 'sessionrestore_no_auto_restore', 19:32:09 INFO - 'tabpaint']}, 19:32:09 INFO - 'other-e10s': {'tests': ['a11yr', 19:32:09 INFO - 'ts_paint', 19:32:09 INFO - 'tpaint', 19:32:09 INFO - 'sessionrestore', 19:32:09 INFO - 'sessionrestore_no_auto_restore', 19:32:09 INFO - 'tabpaint']}, 19:32:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:32:09 INFO - 'ts_paint', 19:32:09 INFO - 'tpaint', 19:32:09 INFO - 'sessionrestore', 19:32:09 INFO - 'sessionrestore_no_auto_restore', 19:32:09 INFO - 'tabpaint']}, 19:32:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:32:09 INFO - 'ts_paint', 19:32:09 INFO - 'tpaint', 19:32:09 INFO - 'sessionrestore', 19:32:09 INFO - 'sessionrestore_no_auto_restore', 19:32:09 INFO - 'tabpaint']}, 19:32:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:32:09 INFO - 'tests': ['a11yr', 19:32:09 INFO - 'ts_paint', 19:32:09 INFO - 'tpaint', 19:32:09 INFO - 'sessionrestore', 19:32:09 INFO - 'sessionrestore_no_auto_restore', 19:32:09 INFO - 'tabpaint']}, 19:32:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:32:09 INFO - 'tests': ['a11yr', 19:32:09 INFO - 'ts_paint', 19:32:09 INFO - 'tpaint', 19:32:09 INFO - 'sessionrestore', 19:32:09 INFO - 'sessionrestore_no_auto_restore', 19:32:09 INFO - 'tabpaint']}, 19:32:09 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 19:32:09 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 19:32:09 INFO - 'bloom_basic_ref']}, 19:32:09 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 19:32:09 INFO - 'talos_options': ['--mitmproxy', 19:32:09 INFO - 'mitmproxy-recording-1.mp', 19:32:09 INFO - '--firstNonBlankPaint'], 19:32:09 INFO - 'tests': ['Quantum_1']}, 19:32:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:32:09 INFO - 'tests': ['tsvgx', 19:32:09 INFO - 'tsvgr_opacity', 19:32:09 INFO - 'tart', 19:32:09 INFO - 'tscrollx', 19:32:09 INFO - 'cart', 19:32:09 INFO - 'tsvg_static']}, 19:32:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:32:09 INFO - 'tsvgr_opacity', 19:32:09 INFO - 'tart', 19:32:09 INFO - 'tscrollx', 19:32:09 INFO - 'cart', 19:32:09 INFO - 'tsvg_static']}, 19:32:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:32:09 INFO - 'talos_options': ['--disable-e10s'], 19:32:09 INFO - 'tests': ['tp5o']}, 19:32:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:32:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:32:09 INFO - 'talos_options': ['--disable-e10s', 19:32:09 INFO - '--xperf_path', 19:32:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:32:09 INFO - 'tests': ['tp5n']}, 19:32:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:32:09 INFO - 'talos_options': ['--xperf_path', 19:32:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:32:09 INFO - 'tests': ['tp5n']}}, 19:32:09 INFO - 'talos.zip': {'path': '', 19:32:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:32:09 INFO - Running post-action listener: _resource_record_post_action 19:32:09 INFO - [mozharness: 2017-06-02 02:32:09.390890Z] Finished populate-webroot step (success) 19:32:09 INFO - [mozharness: 2017-06-02 02:32:09.390981Z] Running create-virtualenv step. 19:32:09 INFO - Running pre-action listener: _resource_record_pre_action 19:32:09 INFO - Running main action method: create_virtualenv 19:32:09 INFO - Creating virtualenv /builds/slave/test/build/venv 19:32:09 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 19:32:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:32:09 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 19:32:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:32:09 INFO - Using real prefix '/usr' 19:32:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:32:10 INFO - Installing distribute.............................................................................................................................................................................................done. 19:32:12 INFO - Installing pip.................done. 19:32:12 INFO - Return code: 0 19:32:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:32:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:32:12 INFO - Reading from file tmpfile_stdout 19:32:12 INFO - Output received: 19:32:12 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) 19:32:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:32:12 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')]} 19:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:12 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')]} 19:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:12 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 0xc923b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d840>, '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 0x100e740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ebd0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174', '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 19:32:12 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 19:32:12 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 19:32:12 INFO - Using env: {'DISPLAY': ':0', 19:32:12 INFO - 'HOME': '/home/cltbld', 19:32:12 INFO - 'LANG': 'en_US.UTF-8', 19:32:12 INFO - 'LANGUAGE': 'en_US:en', 19:32:12 INFO - 'LOGNAME': 'cltbld', 19:32:12 INFO - 'MAIL': '/var/mail/cltbld', 19:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:12 INFO - 'MOZ_NO_REMOTE': '1', 19:32:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:12 INFO - 'NO_EM_RESTART': '1', 19:32:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:12 INFO - 'PWD': '/builds/slave/test', 19:32:12 INFO - 'SHELL': '/bin/bash', 19:32:12 INFO - 'SHLVL': '1', 19:32:12 INFO - 'TERM': 'linux', 19:32:12 INFO - 'TMOUT': '86400', 19:32:12 INFO - 'USER': 'cltbld', 19:32:12 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174', 19:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:12 INFO - '_': '/tools/buildbot/bin/python'} 19:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:12 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 19:32:12 INFO - Cleaning up... 19:32:12 INFO - Return code: 0 19:32:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:32:12 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')]} 19:32:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:12 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')]} 19:32:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:12 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 0xc923b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d840>, '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 0x100e740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ebd0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174', '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 19:32:12 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 19:32:12 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 19:32:12 INFO - Using env: {'DISPLAY': ':0', 19:32:12 INFO - 'HOME': '/home/cltbld', 19:32:12 INFO - 'LANG': 'en_US.UTF-8', 19:32:12 INFO - 'LANGUAGE': 'en_US:en', 19:32:12 INFO - 'LOGNAME': 'cltbld', 19:32:12 INFO - 'MAIL': '/var/mail/cltbld', 19:32:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:12 INFO - 'MOZ_NO_REMOTE': '1', 19:32:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:12 INFO - 'NO_EM_RESTART': '1', 19:32:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:12 INFO - 'PWD': '/builds/slave/test', 19:32:12 INFO - 'SHELL': '/bin/bash', 19:32:12 INFO - 'SHLVL': '1', 19:32:12 INFO - 'TERM': 'linux', 19:32:12 INFO - 'TMOUT': '86400', 19:32:12 INFO - 'USER': 'cltbld', 19:32:12 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174', 19:32:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:12 INFO - '_': '/tools/buildbot/bin/python'} 19:32:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:12 INFO - Downloading/unpacking psutil>=3.1.1 19:32: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 19:32: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 19:32: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 19:32: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 19:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:32:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:32:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:32:14 INFO - Installing collected packages: psutil 19:32:14 INFO - Running setup.py install for psutil 19:32:14 INFO - building 'psutil._psutil_linux' extension 19:32:14 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 19:32:15 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 19:32:15 INFO - building 'psutil._psutil_posix' extension 19:32:15 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 19:32:15 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 19:32:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:32:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:32:15 INFO - Successfully installed psutil 19:32:15 INFO - Cleaning up... 19:32:15 INFO - Return code: 0 19:32:15 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:15 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 0xc923b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d840>, '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 0x100e740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ebd0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174', '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 19:32:15 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 19:32:15 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 19:32:15 INFO - Using env: {'DISPLAY': ':0', 19:32:15 INFO - 'HOME': '/home/cltbld', 19:32:15 INFO - 'LANG': 'en_US.UTF-8', 19:32:15 INFO - 'LANGUAGE': 'en_US:en', 19:32:15 INFO - 'LOGNAME': 'cltbld', 19:32:15 INFO - 'MAIL': '/var/mail/cltbld', 19:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:15 INFO - 'MOZ_NO_REMOTE': '1', 19:32:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:15 INFO - 'NO_EM_RESTART': '1', 19:32:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:15 INFO - 'PWD': '/builds/slave/test', 19:32:15 INFO - 'SHELL': '/bin/bash', 19:32:15 INFO - 'SHLVL': '1', 19:32:15 INFO - 'TERM': 'linux', 19:32:15 INFO - 'TMOUT': '86400', 19:32:15 INFO - 'USER': 'cltbld', 19:32:15 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174', 19:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:15 INFO - '_': '/tools/buildbot/bin/python'} 19:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:15 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:32:15 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 19:32:15 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 19:32:15 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 19:32:15 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 19:32:16 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:32:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:32:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:32:16 INFO - Installing collected packages: mozsystemmonitor 19:32:16 INFO - Running setup.py install for mozsystemmonitor 19:32:16 INFO - Successfully installed mozsystemmonitor 19:32:16 INFO - Cleaning up... 19:32:16 INFO - Return code: 0 19:32:16 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:32:16 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')]} 19:32:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:16 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')]} 19:32:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:16 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 0xc923b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d840>, '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 0x100e740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ebd0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174', '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 19:32:16 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 19:32:16 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 19:32:16 INFO - Using env: {'DISPLAY': ':0', 19:32:16 INFO - 'HOME': '/home/cltbld', 19:32:16 INFO - 'LANG': 'en_US.UTF-8', 19:32:16 INFO - 'LANGUAGE': 'en_US:en', 19:32:16 INFO - 'LOGNAME': 'cltbld', 19:32:16 INFO - 'MAIL': '/var/mail/cltbld', 19:32:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:16 INFO - 'MOZ_NO_REMOTE': '1', 19:32:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:16 INFO - 'NO_EM_RESTART': '1', 19:32:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:16 INFO - 'PWD': '/builds/slave/test', 19:32:16 INFO - 'SHELL': '/bin/bash', 19:32:16 INFO - 'SHLVL': '1', 19:32:16 INFO - 'TERM': 'linux', 19:32:16 INFO - 'TMOUT': '86400', 19:32:16 INFO - 'USER': 'cltbld', 19:32:16 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174', 19:32:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:16 INFO - '_': '/tools/buildbot/bin/python'} 19:32:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:17 INFO - Downloading/unpacking jsonschema==2.5.1 19:32:17 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 19:32:17 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 19:32:17 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 19:32:17 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 19:32:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:32:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:32: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 19:32: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 19:32: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 19:32: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 19:32:18 INFO - Downloading functools32-3.2.3-2.tar.gz 19:32:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:32:18 INFO - warning: no files found matching '*.txt' 19:32:18 INFO - no previously-included directories found matching 'build' 19:32:18 INFO - no previously-included directories found matching 'dist' 19:32:18 INFO - no previously-included directories found matching '.git*' 19:32:18 INFO - Installing collected packages: jsonschema, functools32 19:32:18 INFO - Running setup.py install for functools32 19:32:18 INFO - warning: no files found matching '*.txt' 19:32:18 INFO - no previously-included directories found matching 'build' 19:32:18 INFO - no previously-included directories found matching 'dist' 19:32:18 INFO - no previously-included directories found matching '.git*' 19:32:18 INFO - Successfully installed jsonschema functools32 19:32:18 INFO - Cleaning up... 19:32:18 INFO - Return code: 0 19:32:18 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:32:18 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')]} 19:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:18 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')]} 19:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:18 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 0xc923b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d840>, '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 0x100e740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ebd0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174', '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 19:32:18 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 19:32:18 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 19:32:18 INFO - Using env: {'DISPLAY': ':0', 19:32:18 INFO - 'HOME': '/home/cltbld', 19:32:18 INFO - 'LANG': 'en_US.UTF-8', 19:32:18 INFO - 'LANGUAGE': 'en_US:en', 19:32:18 INFO - 'LOGNAME': 'cltbld', 19:32:18 INFO - 'MAIL': '/var/mail/cltbld', 19:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:18 INFO - 'MOZ_NO_REMOTE': '1', 19:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:18 INFO - 'NO_EM_RESTART': '1', 19:32:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:18 INFO - 'PWD': '/builds/slave/test', 19:32:18 INFO - 'SHELL': '/bin/bash', 19:32:18 INFO - 'SHLVL': '1', 19:32:18 INFO - 'TERM': 'linux', 19:32:18 INFO - 'TMOUT': '86400', 19:32:18 INFO - 'USER': 'cltbld', 19:32:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174', 19:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:18 INFO - '_': '/tools/buildbot/bin/python'} 19:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:18 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:32:18 INFO - Cleaning up... 19:32:18 INFO - Return code: 0 19:32:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:32:18 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')]} 19:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:18 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')]} 19:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:18 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 0xc923b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d840>, '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 0x100e740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ebd0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174', '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 19:32:18 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 19:32:18 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 19:32:18 INFO - Using env: {'DISPLAY': ':0', 19:32:18 INFO - 'HOME': '/home/cltbld', 19:32:18 INFO - 'LANG': 'en_US.UTF-8', 19:32:18 INFO - 'LANGUAGE': 'en_US:en', 19:32:18 INFO - 'LOGNAME': 'cltbld', 19:32:18 INFO - 'MAIL': '/var/mail/cltbld', 19:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:18 INFO - 'MOZ_NO_REMOTE': '1', 19:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:18 INFO - 'NO_EM_RESTART': '1', 19:32:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:18 INFO - 'PWD': '/builds/slave/test', 19:32:18 INFO - 'SHELL': '/bin/bash', 19:32:18 INFO - 'SHLVL': '1', 19:32:18 INFO - 'TERM': 'linux', 19:32:18 INFO - 'TMOUT': '86400', 19:32:18 INFO - 'USER': 'cltbld', 19:32:18 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174', 19:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:18 INFO - '_': '/tools/buildbot/bin/python'} 19:32:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:19 INFO - Downloading/unpacking blobuploader==1.2.4 19:32:19 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 19:32:19 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 19:32:19 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 19:32:19 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 19:32:20 INFO - Downloading blobuploader-1.2.4.tar.gz 19:32:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:32:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:32: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 19:32: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 19:32: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 19:32: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 19:32:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:32:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:32: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 19:32: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 19:32: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 19:32: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 19:32:20 INFO - Downloading docopt-0.6.1.tar.gz 19:32:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:32:20 INFO - Installing collected packages: blobuploader, requests, docopt 19:32:20 INFO - Running setup.py install for blobuploader 19:32:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:32:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:32:20 INFO - Running setup.py install for requests 19:32:21 INFO - Running setup.py install for docopt 19:32:21 INFO - Successfully installed blobuploader requests docopt 19:32:21 INFO - Cleaning up... 19:32:21 INFO - Return code: 0 19:32:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:32: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')]} 19:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32: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')]} 19:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:21 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 0xc923b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d840>, '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 0x100e740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ebd0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174', '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 19:32:21 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 19:32:21 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 19:32:21 INFO - Using env: {'DISPLAY': ':0', 19:32:21 INFO - 'HOME': '/home/cltbld', 19:32:21 INFO - 'LANG': 'en_US.UTF-8', 19:32:21 INFO - 'LANGUAGE': 'en_US:en', 19:32:21 INFO - 'LOGNAME': 'cltbld', 19:32:21 INFO - 'MAIL': '/var/mail/cltbld', 19:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:21 INFO - 'MOZ_NO_REMOTE': '1', 19:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:21 INFO - 'NO_EM_RESTART': '1', 19:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:21 INFO - 'PWD': '/builds/slave/test', 19:32:21 INFO - 'SHELL': '/bin/bash', 19:32:21 INFO - 'SHLVL': '1', 19:32:21 INFO - 'TERM': 'linux', 19:32:21 INFO - 'TMOUT': '86400', 19:32:21 INFO - 'USER': 'cltbld', 19:32:21 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174', 19:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:21 INFO - '_': '/tools/buildbot/bin/python'} 19:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:32:21 INFO - Running setup.py (path:/tmp/pip-Bwh1yb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:32:21 INFO - Running setup.py (path:/tmp/pip-DgHuBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:32:21 INFO - Running setup.py (path:/tmp/pip-syKrad-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:32:21 INFO - Running setup.py (path:/tmp/pip-HL12xN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:32:21 INFO - Running setup.py (path:/tmp/pip-Tdox9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:32:21 INFO - Running setup.py (path:/tmp/pip-birwVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:32:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:32:21 INFO - Running setup.py (path:/tmp/pip-DaQP6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:32:22 INFO - Running setup.py (path:/tmp/pip-uu6Ffw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:32:22 INFO - Running setup.py (path:/tmp/pip-rH6u9d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:32:22 INFO - Running setup.py (path:/tmp/pip-fbXfZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:32:22 INFO - Running setup.py (path:/tmp/pip-1kY9hA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:32:22 INFO - Running setup.py (path:/tmp/pip-Kw7d2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:32:22 INFO - Running setup.py (path:/tmp/pip-qvrTan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:32:22 INFO - Running setup.py (path:/tmp/pip-UMQg9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:32:22 INFO - Running setup.py (path:/tmp/pip-_KduIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:32:22 INFO - Running setup.py (path:/tmp/pip-Er_0Vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:32:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:32:22 INFO - Running setup.py (path:/tmp/pip-TpBtHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:32:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:32:22 INFO - Running setup.py install for manifestparser 19:32:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:32:22 INFO - Running setup.py install for mozcrash 19:32:22 INFO - Running setup.py install for mozdebug 19:32:23 INFO - Running setup.py install for mozdevice 19:32:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:32:23 INFO - Running setup.py install for mozfile 19:32:23 INFO - Running setup.py install for mozhttpd 19:32:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:32:23 INFO - Running setup.py install for mozinfo 19:32:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:32:23 INFO - Running setup.py install for mozInstall 19:32:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:32:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:32:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:32:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:32:23 INFO - Running setup.py install for mozleak 19:32:23 INFO - Running setup.py install for mozlog 19:32:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:32:23 INFO - Running setup.py install for moznetwork 19:32:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:32:23 INFO - Running setup.py install for mozprocess 19:32:23 INFO - Running setup.py install for mozprofile 19:32:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:32:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:32:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:32:24 INFO - Running setup.py install for mozrunner 19:32:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:32:24 INFO - Running setup.py install for mozscreenshot 19:32:24 INFO - Running setup.py install for moztest 19:32:24 INFO - Running setup.py install for mozversion 19:32:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:32:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:32:24 INFO - Cleaning up... 19:32:24 INFO - Return code: 0 19:32:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:24 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 0xc923b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d840>, '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 0x100e740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ebd0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174', '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 19:32:24 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 19:32:24 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 19:32:24 INFO - Using env: {'DISPLAY': ':0', 19:32:24 INFO - 'HOME': '/home/cltbld', 19:32:24 INFO - 'LANG': 'en_US.UTF-8', 19:32:24 INFO - 'LANGUAGE': 'en_US:en', 19:32:24 INFO - 'LOGNAME': 'cltbld', 19:32:24 INFO - 'MAIL': '/var/mail/cltbld', 19:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:24 INFO - 'MOZ_NO_REMOTE': '1', 19:32:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:24 INFO - 'NO_EM_RESTART': '1', 19:32:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:24 INFO - 'PWD': '/builds/slave/test', 19:32:24 INFO - 'SHELL': '/bin/bash', 19:32:24 INFO - 'SHLVL': '1', 19:32:24 INFO - 'TERM': 'linux', 19:32:24 INFO - 'TMOUT': '86400', 19:32:24 INFO - 'USER': 'cltbld', 19:32:24 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174', 19:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:24 INFO - '_': '/tools/buildbot/bin/python'} 19:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:32:24 INFO - Running setup.py (path:/tmp/pip-lntymO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:32:24 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)) 19:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:32:24 INFO - Running setup.py (path:/tmp/pip-zDBkGS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:32:24 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)) 19:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:32:24 INFO - Running setup.py (path:/tmp/pip-S2Pcmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:32:24 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)) 19:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:32:24 INFO - Running setup.py (path:/tmp/pip-iwKDf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:32:25 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)) 19:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:32:25 INFO - Running setup.py (path:/tmp/pip-U3Bcyg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:32:25 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)) 19:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:32:25 INFO - Running setup.py (path:/tmp/pip-tDMNLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:32:25 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)) 19:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:32:25 INFO - Running setup.py (path:/tmp/pip-r07qlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:32:25 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)) 19:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:32:25 INFO - Running setup.py (path:/tmp/pip-w_lZCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:32:25 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)) 19:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:32:25 INFO - Running setup.py (path:/tmp/pip-uU7iJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:32:25 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)) 19:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:32:25 INFO - Running setup.py (path:/tmp/pip-BgDedW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:32:25 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)) 19:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:32:25 INFO - Running setup.py (path:/tmp/pip-j5wrlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:32:25 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)) 19:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:32:25 INFO - Running setup.py (path:/tmp/pip-QrNcIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:32:25 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)) 19:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:32:25 INFO - Running setup.py (path:/tmp/pip-XiVjQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:32:25 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)) 19:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:32:25 INFO - Running setup.py (path:/tmp/pip-xgjxmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:32:25 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)) 19:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:32:25 INFO - Running setup.py (path:/tmp/pip-2xyH6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:32:25 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)) 19:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:32:25 INFO - Running setup.py (path:/tmp/pip-Bq8gqK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:32:25 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)) 19:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:32:25 INFO - Running setup.py (path:/tmp/pip-VLmKpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:32:25 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)) 19:32:25 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)) 19:32:25 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)) 19:32:25 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)) 19:32:25 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)) 19:32:25 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)) 19:32:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:32:25 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 19:32:25 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 19:32:25 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 19:32:26 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 19:32:27 INFO - Downloading blessings-1.6.tar.gz 19:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:32:27 INFO - Installing collected packages: blessings 19:32:27 INFO - Running setup.py install for blessings 19:32:27 INFO - Successfully installed blessings 19:32:27 INFO - Cleaning up... 19:32:27 INFO - Return code: 0 19:32:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:32:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:32:27 INFO - Reading from file tmpfile_stdout 19:32:27 INFO - Current package versions: 19:32:27 INFO - argparse == 1.2.1 19:32:27 INFO - blessings == 1.6 19:32:27 INFO - blobuploader == 1.2.4 19:32:27 INFO - docopt == 0.6.1 19:32:27 INFO - functools32 == 3.2.3-2 19:32:27 INFO - jsonschema == 2.5.1 19:32:27 INFO - manifestparser == 1.1 19:32:27 INFO - mozInstall == 1.12 19:32:27 INFO - mozcrash == 1.0 19:32:27 INFO - mozdebug == 0.1 19:32:27 INFO - mozdevice == 0.51 19:32:27 INFO - mozfile == 1.2 19:32:27 INFO - mozhttpd == 0.7 19:32:27 INFO - mozinfo == 0.9 19:32:27 INFO - mozleak == 0.1 19:32:27 INFO - mozlog == 3.4 19:32:27 INFO - moznetwork == 0.27 19:32:27 INFO - mozprocess == 0.25 19:32:27 INFO - mozprofile == 0.28 19:32:27 INFO - mozrunner == 6.13 19:32:27 INFO - mozscreenshot == 0.1 19:32:27 INFO - mozsystemmonitor == 0.3 19:32:27 INFO - moztest == 0.8 19:32:27 INFO - mozversion == 1.4 19:32:27 INFO - psutil == 3.1.1 19:32:27 INFO - requests == 1.2.3 19:32:27 INFO - wsgiref == 0.1.2 19:32:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:27 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 0xc923b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d840>, '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 0x100e740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ebd0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174', '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 19:32:27 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 19:32:27 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 19:32:27 INFO - Using env: {'DISPLAY': ':0', 19:32:27 INFO - 'HOME': '/home/cltbld', 19:32:27 INFO - 'LANG': 'en_US.UTF-8', 19:32:27 INFO - 'LANGUAGE': 'en_US:en', 19:32:27 INFO - 'LOGNAME': 'cltbld', 19:32:27 INFO - 'MAIL': '/var/mail/cltbld', 19:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:27 INFO - 'MOZ_NO_REMOTE': '1', 19:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:27 INFO - 'NO_EM_RESTART': '1', 19:32:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:27 INFO - 'PWD': '/builds/slave/test', 19:32:27 INFO - 'SHELL': '/bin/bash', 19:32:27 INFO - 'SHLVL': '1', 19:32:27 INFO - 'TERM': 'linux', 19:32:27 INFO - 'TMOUT': '86400', 19:32:27 INFO - 'USER': 'cltbld', 19:32:27 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174', 19:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:27 INFO - '_': '/tools/buildbot/bin/python'} 19:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:27 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)) 19:32:27 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)) 19:32:27 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)) 19:32:27 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)) 19:32:27 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)) 19:32:27 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)) 19:32:27 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)) 19:32:27 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)) 19:32:27 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)) 19:32:27 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 19:32:27 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 19:32:27 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 19:32:27 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 19:32:27 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 19:32:28 INFO - Downloading marionette_driver-1.4.0.tar.gz 19:32:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 19:32:28 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)) 19:32:28 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)) 19:32:28 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)) 19:32:28 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)) 19:32:28 INFO - Installing collected packages: marionette-driver 19:32:28 INFO - Running setup.py install for marionette-driver 19:32:29 INFO - Successfully installed marionette-driver 19:32:29 INFO - Cleaning up... 19:32:29 INFO - Return code: 0 19:32:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:32:29 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')]} 19:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:32:29 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')]} 19:32:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:32:29 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 0xc923b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe6ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1010dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100d840>, '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 0x100e740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ebd0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174', '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 19:32:29 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 19:32:29 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 19:32:29 INFO - Using env: {'DISPLAY': ':0', 19:32:29 INFO - 'HOME': '/home/cltbld', 19:32:29 INFO - 'LANG': 'en_US.UTF-8', 19:32:29 INFO - 'LANGUAGE': 'en_US:en', 19:32:29 INFO - 'LOGNAME': 'cltbld', 19:32:29 INFO - 'MAIL': '/var/mail/cltbld', 19:32:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:29 INFO - 'MOZ_NO_REMOTE': '1', 19:32:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:29 INFO - 'NO_EM_RESTART': '1', 19:32:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:29 INFO - 'PWD': '/builds/slave/test', 19:32:29 INFO - 'SHELL': '/bin/bash', 19:32:29 INFO - 'SHLVL': '1', 19:32:29 INFO - 'TERM': 'linux', 19:32:29 INFO - 'TMOUT': '86400', 19:32:29 INFO - 'USER': 'cltbld', 19:32:29 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174', 19:32:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:29 INFO - '_': '/tools/buildbot/bin/python'} 19:32:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:32:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:32:29 INFO - Cleaning up... 19:32:29 INFO - Return code: 0 19:32:29 INFO - Running post-action listener: _resource_record_post_action 19:32:29 INFO - Running post-action listener: _start_resource_monitoring 19:32:29 INFO - Starting resource monitoring. 19:32:29 INFO - [mozharness: 2017-06-02 02:32:29.305903Z] Finished create-virtualenv step (success) 19:32:29 INFO - [mozharness: 2017-06-02 02:32:29.306364Z] Running install step. 19:32:29 INFO - Running pre-action listener: _resource_record_pre_action 19:32:29 INFO - Running main action method: install 19:32:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:32:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:32:29 INFO - Reading from file tmpfile_stdout 19:32:29 INFO - Detecting whether we're running mozinstall >=1.0... 19:32:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:32:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:32:29 INFO - Reading from file tmpfile_stdout 19:32:29 INFO - Output received: 19:32:29 INFO - Usage: mozinstall [options] installer 19:32:29 INFO - Options: 19:32:29 INFO - -h, --help show this help message and exit 19:32:29 INFO - -d DEST, --destination=DEST 19:32:29 INFO - Directory to install application into. [default: 19:32:29 INFO - "/builds/slave/test"] 19:32:29 INFO - --app=APP Application being installed. [default: firefox] 19:32:29 INFO - mkdir: /builds/slave/test/build/application 19:32:29 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'] 19:32:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:32:45 INFO - Reading from file tmpfile_stdout 19:32:45 INFO - Output received: 19:32:45 INFO - /builds/slave/test/build/application/firefox/firefox 19:32:45 INFO - Running post-action listener: _resource_record_post_action 19:32:45 INFO - [mozharness: 2017-06-02 02:32:45.666434Z] Finished install step (success) 19:32:45 INFO - [mozharness: 2017-06-02 02:32:45.666711Z] Running setup-mitmproxy step. 19:32:45 INFO - Running pre-action listener: _resource_record_pre_action 19:32:45 INFO - Running main action method: setup_mitmproxy 19:32:45 INFO - Skipping: mitmproxy is not required 19:32:45 INFO - Running post-action listener: _resource_record_post_action 19:32:45 INFO - [mozharness: 2017-06-02 02:32:45.667851Z] Finished setup-mitmproxy step (success) 19:32:45 INFO - [mozharness: 2017-06-02 02:32:45.668074Z] Running run-tests step. 19:32:45 INFO - Running pre-action listener: _resource_record_pre_action 19:32:45 INFO - Running main action method: run_tests 19:32:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:32:45 INFO - Python 2.7.3 19:32:45 INFO - Return code: 0 19:32:45 INFO - grabbing minidump binary from tooltool 19:32:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:32:45 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 0x100d840>, '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 0x100e740>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100ebd0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:32:45 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 19:32:45 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 19:32:45 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 19:32:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:32:45 INFO - Return code: 0 19:32:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:32:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:32:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:32:45 INFO - ENV: RUST_BACKTRACE is now 1 19:32:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:32:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:32:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 19:32:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-042 --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 19:32:45 INFO - Using env: {'DISPLAY': ':0', 19:32:45 INFO - 'HOME': '/home/cltbld', 19:32:45 INFO - 'LANG': 'en_US.UTF-8', 19:32:45 INFO - 'LANGUAGE': 'en_US:en', 19:32:45 INFO - 'LOGNAME': 'cltbld', 19:32:45 INFO - 'MAIL': '/var/mail/cltbld', 19:32:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:32:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:32:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:32:45 INFO - 'MOZ_NO_REMOTE': '1', 19:32:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:32:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:32:45 INFO - 'NO_EM_RESTART': '1', 19:32:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:32:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:32:45 INFO - 'PWD': '/builds/slave/test', 19:32:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:32:45 INFO - 'RUST_BACKTRACE': '1', 19:32:45 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 19:32:45 INFO - 'SHELL': '/bin/bash', 19:32:45 INFO - 'SHLVL': '1', 19:32:45 INFO - 'TERM': 'linux', 19:32:45 INFO - 'TMOUT': '86400', 19:32:45 INFO - 'USER': 'cltbld', 19:32:45 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174', 19:32:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:32:45 INFO - '_': '/tools/buildbot/bin/python'} 19:32:45 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--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 19:32:46 INFO - mozversion application_buildid: 20170602015025 19:32:46 INFO - mozversion application_changeset: aeb3d0ca558f034cbef1c5a68bd07dd738611494 19:32:46 INFO - mozversion application_display_name: Nightly 19:32:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:32:46 INFO - mozversion application_name: Firefox 19:32:46 INFO - mozversion application_remotingname: firefox 19:32:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:32:46 INFO - mozversion application_vendor: Mozilla 19:32:46 INFO - mozversion application_version: 55.0a1 19:32:46 INFO - mozversion platform_buildid: 20170602015025 19:32:46 INFO - mozversion platform_changeset: aeb3d0ca558f034cbef1c5a68bd07dd738611494 19:32:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:32:46 INFO - mozversion platform_version: 55.0a1 19:32:46 INFO - using testdate: 1496370766 19:32:46 INFO - actual date: 1496370766 19:32:46 INFO - starting webserver on 'localhost:36498' 19:32:46 INFO - SUITE-START | Running 2 tests 19:32:46 INFO - TEST-START | dromaeo_css 19:32:46 INFO - operating with platform_type : linux_ 19:32:46 INFO - Initialising browser for dromaeo_css test... 19:32:46 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36498/getInfo.html -profile /tmp/tmpcbT6ZF/profile 19:32:46 INFO - TEST-INFO | started process 3316 (/builds/slave/test/build/application/firefox/firefox http://localhost:36498/getInfo.html) 19:33:24 INFO - TEST-INFO | 3316: killed by SIGTERM 19:33:24 INFO - Browser initialized. 19:33:24 INFO - Running cycle 1/1 for dromaeo_css test... 19:33:24 INFO - TEST-INFO | started process 3542 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcbT6ZF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:33:36 INFO - PID 3542 | RSS: Main: 197406720 19:33:36 INFO - PID 3542 | 19:36:40 INFO - PID 3542 | Cycle 1(1): loaded http://localhost:36498/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36498/tests/dromaeo/cssquery-ext.html) 19:36:41 INFO - PID 3542 | RSS: Main: 182575104 19:36:41 INFO - PID 3542 | 19:39:43 INFO - PID 3542 | Cycle 1(1): loaded http://localhost:36498/tests/dromaeo/cssquery-ext.html (next: http://localhost:36498/tests/dromaeo/cssquery-jquery.html) 19:39:44 INFO - PID 3542 | RSS: Main: 190173184 19:39:44 INFO - PID 3542 | 19:42:46 INFO - PID 3542 | Cycle 1(1): loaded http://localhost:36498/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36498/tests/dromaeo/cssquery-mootools.html) 19:42:46 INFO - PID 3542 | RSS: Main: 185114624 19:42:46 INFO - PID 3542 | 19:45:48 INFO - PID 3542 | Cycle 1(1): loaded http://localhost:36498/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36498/tests/dromaeo/cssquery-prototype.html) 19:45:49 INFO - PID 3542 | RSS: Main: 188964864 19:45:49 INFO - PID 3542 | 19:48:52 INFO - PID 3542 | Cycle 1(1): loaded http://localhost:36498/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36498/tests/dromaeo/cssquery-yui.html) 19:48:53 INFO - PID 3542 | RSS: Main: 189677568 19:48:53 INFO - PID 3542 | 19:51:54 INFO - PID 3542 | Cycle 1(1): loaded http://localhost:36498/tests/dromaeo/cssquery-yui.html (next: http://localhost:36498/tests/dromaeo/cssquery-dojo.html) 19:51:55 INFO - PID 3542 | RSS: Main: 187310080 19:51:55 INFO - PID 3542 | 19:51:55 INFO - PID 3542 | __start_tp_report 19:51:55 INFO - PID 3542 | _x_x_mozilla_page_load 19:51:55 INFO - PID 3542 | _x_x_mozilla_page_load_details 19:51:55 INFO - PID 3542 | |i|pagename|runs| 19:51:55 INFO - PID 3542 | |0;dojo.html;2687.5162470755263;2688.9731102688966;2718.1166121010665;2724.2235962750615;2731.4264004559027;4987.226979818125;5076.64463487556;5120.513551212638;5127.538521533062;5153.046686363021;5028.723420211896;5053.418856831466;5113.207452844815;5128.076946149691;5156.020356132332;4598.356230127785;4615.192341340269;4640.721556706591;4641.582257596816;4679.134360143385;4615.100055489181;4647.837325693601;4668.883277918046;4696;4740.099381117594;4502.909941801146;4564.018735971748;4625.468071171825;4637.1421287062;4697.13103075932;4530.365748795171;4621.098885717286;4624.583787459112;4645.512221216757;4676.415448068991;4573.405457290564;4592.885177870547;4601.953980460186;4619.330197121432;4631.58315751584;5018.096742586333;5079.822206222764;5164;5164.04465173944;5167.819126330598;5491.533219676332;5559.861003474905;5566.6201951802595;5600;5603.915941260843;5510.256115424407;5519.199716041152;5522.337319521643;5527.419620939783;5528.861778455531;5118.692878427269;5141.691498510101;5151.639385242997;5156.355455568054;5193.3767947845745;5456.181572764038;5517.69652669107;5529.585281103933;5637.295338082739;5744.540436765049;5428.67427954324;5431.592630552725;5440.782368705287;5469.398366179717;5488.396276409591;5482.424345443671;5509.47659972302;5517.200005999108;5524.502794748492;5527.806526771544;5387.757550910218;5425.511703946585;5474.479924407175;5493.533049690821;5531.668099914018;5470.72646367688;5536.335639723259;5541.5843811714285;5544.251526043932;5546.861328466821;4488.775561221926;4573.039661671086;4582.610478109332;4609.331646911179;4639.930401043919;3910.921781564353;3912.2175564886566;3918.8236529356245;3949.585293544194;3954.8220330085214;4514.932276015797;4563.566461186182;4578.404807375086;4604.0791841631135;4651.116287905287;5594.272744543265;5620.522255608237;5621.887562248814;5623.2408624835125;5678.14827775837;4671.719696818202;4677.4387073550715;4677.812887484531;4687.789049492712;4717.764111794397;4755.405574303212;4816.4220293564995;4824.962633033914;4880;4892.094962431962;5174.275601415729;5175.378954525481;5201.479852014768;5214.765335559833;5224.085784987536;5430.619856609999;5509.035918714289;5520.585956053232;5562.91655625174;5565.526930210977;5113;5125.513076257749;5156.303898973591;5165.560927321069;5168.9483105168465;5352.170413585901;5427.891442171213;5436.592255580768;5461.808836690856;5467.58993075513;5604.8038318658655;5639.407862174413;5647.29408823897;5648.068068768772;5651.095824668033;5431.864203394946;5434.10337294342;5441.591880608891;5442.238086667949;5482.533984611193;5425.565954723534;5429.022775900376;5437.293151890229;5440;5478.233047373451;5118.564921981673;5209.0363282792805;5271.4464981176425;5353.063213937623;5362.195670649434;5398.9190162146815;5410.567154627542;5441.918371224356;5448.618596698193;5450.127979523258;5229.006488767274;5233.7383130842545;5249.553787928069;5253.159494480865;5288.4182739897815 19:51:55 INFO - PID 3542 | |1;ext.html;705.3722187253344;729.8430837369964;1049.2602715085861;1071.8981696738813;1182.5801840346671;31978.520322195185;32745.67254327453;32793.34413311732;32825.5076173857;32876;31358;31572.210694732643;31765.205869853264;31785.68214317856;31792;6461.7415303387925;6499.38255865692;6590.406863382294;6716.597004179765;6730.125083739107;6712.630805305706;6795.524313298071;6801.591904485722;6804.3876051155385;6815.659217039153;6695.966520167417;6730.461563074967;6748.122744043268;6795.728170873159;6817.931820681779;6695.899561506581;6751.763688270887;6758.256591774901;6793.66031698418;6806.081179040815;6555.31169227229;6583.572067815577;6610.438112760421;6633.436157926534;6650.168728908887;30090.24774380636;30362.089137325915;30468.39063218723;30480.84759576188;30491;2905.6513218413716;2914.9562756558457;2925.531914893607;2942.102658689099;2975.9702402976127;23674.64488032681;23678.17126400585;23780.524389512288;23879.64180537276;23899.641505377433;2831.263871393432;2843.772498200139;2844.1894060192953;2850.6151669524766;2867.698891616371;141918;142289;142861.28569357086;143158.99999999895;143234;32757;33305;37454.81272593619;37469.437958430644;39764;38710.2257954845;38903.665780053285;38915.80542097271;38962;39007;11186.720331991603;11305.604303849326;11329.263597866113;11337.489812958436;11342.319460832376;8773.780655483664;8778.209961103532;8786.297096232285;8854.822903541894;8871.512066836256;12210.389480525939;12273;12390.194637348544;12396.81404778929;12496.81254781179;5022.74886255693;5148;5168.3539557555305;5272.209168624737;5290.682559046392;833.5707110837923;863.210162701134;883.4346018548134;885.0927799005941;899.2131884600974;19674.803251967583;20666.689999650018;20737.163624729474;21063;21137.154513819583;946.2855544064188;952.3999880075646;953.5661274120258;966.1304825656965;967.5210770668564;10301.793964120825;10437.843432348522;10603.893961060445;10969.83545246822;11040;169172;169390;170081;170409;170476;37338.62661373351;37561.43657845134;38053.61946380556;38087;38444.61555384466;1125.0999200639455;1181.2794195540541;1185.7450648110525;1187.7565099154654;1193.1826698711411;19183.136758845605;20031.699524507436;20602.587948240653;20619.896900515403;21008.159673612885;28077;28112.156635300973;28165.43669126565;28167.43665126727;28700;146105;146661.26669366585;146904;147257;147348;27253.454930900873;27260.454790904467;27841.860790695915;28148.71851281461;28242.2939426516;33979.830100849336;34319.656803431644;34390;34423.82788086044;35185.296294074484;24820.50358992774;25939.740602594487;26227.60658590161;27096;27335.179944601692;26120;26525;26872.865635671697;26956.865215673795;27875.721242788124;28678.713212867606;29533.704662953096;29676;30031.099067028023;30136.095917122522;25615.743842561336;25630.359241019123;25716.357091072874;26080.8695956519;26778.196654100408;20810.375688729364;21541.569168616228;21666.6749998747;21724;21907.342779716633 19:51:55 INFO - PID 3542 | |2;jquery.html;399.6103798796174;407.8001779128228;407.85724996251304;417.65543426672986;419.50917426610863;13173.60479185626;13705.862941370584;17263.223154958025;17727.02501362426;17736.822631773677;17906.283748650072;18587.721184182214;18659.626807463843;18692.813071869277;18694.71957920629;5457.399686034533;5640.915386269209;5647.265855438808;5647.887042259153;5656.038473459522;5472.50747432731;5544.417836127209;5546.833594992137;5551.333839939213;5553.055980483307;5529.917051244234;5536.390996990328;5539.086050801633;5541.778328866841;5548.528375088123;5345.518903298703;5373.731313434332;5413.215083812865;5420.430854760233;5431.646942948715;4903.583195428393;4903.901921961541;4905.362302900636;4905.558499735041;4907.975460122712;21290.25484108049;21495.247666331605;21588.517320508185;21604;21620;1615.0471221978971;1664.3592216996544;1664.525610201099;1665.758465022577;1667.0164602884236;14340.35468403914;14617.342219600143;14822.555323340317;14982.250887455693;15067.17130557819;1827.2873579304082;1850.8982005989665;1866.6360059788346;1902.4197619725978;1908.351160605387;88198.5590072052;88921.55539222326;89028.55485722594;89145;89831.55084224603;10253.058085602279;10941.781164376667;11011.61459348919;11610.361430121255;11780.941095294469;15464.690706185813;15546.37814487408;15552.066875987477;15624.218789060502;15686.450974215848;7569.5079819811535;7585.544867307979;7651;7660.1573826879;7759.728409505753;6970.442364610819;6976.7209311627985;7016.92983070173;7106.786796396013;7126.35862772353;6742.292059333798;6823.997441125889;6973.5118541701595;6984.3364880336285;7077.372204393018;1904.5048287445363;1974.5162435203467;2016.9798302016793;2024.514116612032;2148.2266384101713;729.7372945739529;819.1112642782648;851.7700220940435;856.032683068129;858.5964596639569;16593;17090.145492725314;17208.913955430144;17369.392071277445;17554.824451755576;849.4521033933079;854.786303424144;864.2524216552762;868.1795703060548;874.3573473496974;9210.46062288435;9400.106989835955;9508.144267016001;9574.329796914288;9690.854637180448;384290;389095;389200;392396;403857;90403.54798225967;90430.54784726034;91721.54139229261;92762.53618731863;93516;986.7286496213599;988.2983082011708;1021.7752094539189;1023.8259495885717;1029.0943969306961;14346.856531434969;14972.775408368665;15108.471203507825;15506.9224653876;15648.139352335731;40807.59192408038;41033;41608.375874362515;41881.79059104685;42219.7889010553;54074.72962635162;54429.45570544244;54780.45219547913;55091.17363239635;55444.44555554393;9054.592543335433;9145.588448519966;9215;9251;9272.675456359266;14791.630209244855;14846.480373186887;15255.618609534851;15574.532764017098;15843.128627925575;12319.322437266037;12330.630081097223;12372.690682733004;12533.248005119722;12619.87380126187;11360.375179365214;12269.877301226874;12407.069469789622;12433.689157770767;12447.315397653216;12762.872371276168;12840.101192916407;13036.674083147996;13072.673183170496;13090.14914030585;9161.404508707179;9231.86152207704;9245.399049062058;9250.537473126451;9306.162445379949;12691;12776.425060872098;12817.23096614206;12824.166429182447;13027.544035958696 19:51:55 INFO - PID 3542 | |3;mootools.html;1225.8528976522816;1302.6938669412687;1305.3995162225376;1310.842698876135;1323.2986517145914;8859.911400885998;9117.635294588208;9246.630134794601;9272.53637318134;9386.29602779791;9289.163975242227;9515.762105947337;9535.427874327544;9544.475053872035;9550.044995500446;1965.4594986378754;1990.5123244805043;1998.5703073839122;2005.6790913453851;2007.6586980213326;1878.9906050469797;1911.0922311901875;1924.5765931495118;1924.8845069295817;1934.6324198402328;1938.2537722976615;1944.3680803738841;1944.6207989442064;1947.4255094747014;1949.727038214651;1853.3883818339982;1871.017715699262;1872.522506760781;1883.1902282018727;1887.2262372427376;1861.4508719927653;1877.7840548336978;1917.3864363403716;2005.6289586426412;2007.197121151551;8890.955545222298;8958.776030599221;8966.686165984225;8967.686130985385;8969.372143949926;4759.50025247351;4944.110060189165;4945.579625731817;4947.653664243504;4968.478309777457;2981.254686328418;3090.6974304143555;3118.080166350909;3149.7322727567953;3155.558221848943;1021.5403068619152;1043.3218408034763;1054.6256079091888;1065.5737704918017;1070.122499550369;11594.362310072942;11957.461914213794;12431.440585173688;12598.181118227378;12619.873801262054;3969.4839670842607;4152.522459917148;4158.313878210061;4164.875053748332;4175.749455032707;9950.10449059588;10044.949775251076;10067.899321006696;10078.092971632588;10122.392656440637;4713.976430117896;4754.4532378776885;4782.139214941274;4785.49752276013;4808.182608956416;4430.867073987785;4459.353393757887;4506.3465797459185;4545.045540436479;4564.931526027112;3572.3391172633146;3671.2840996006057;3674.5669189016303;3721.2743515014313;3763.284975854579;1065.3661071662348;1065.4353192807823;1066.0565399621237;1075.0485820049312;1077.3105212663902;696.2932623387265;713.3045280851233;713.8679344321317;718.2063819479505;731.9707211711578;5059.696418214919;5135.794568217304;5203.271541984125;5258.474152584711;5358.303420555303;537.0601447466933;544.6595877576515;548.7064420534995;565.0873838750471;807.2250639386255;3404.5744281964753;3455.7926524408617;3467.4452087665854;3473.6700013498676;3558.1104723819044;11199.944000279946;11651.941740291244;11873.643790686294;11878.049756019498;11893.524259029715;11701.88298117008;11802.350870702194;11805.999999999829;11884.227525210834;11903.285802851857;6417.8716425672155;6477.4170324671;6533.216014078341;6644.534882558271;6664.466842652576;5039.193729003342;5079.415867175175;5284.947150528599;5410.621256512007;5422.427496026108;10396.792064158826;10634;10722.356658600509;10728.624498142528;10738.516766745672;9895.802083958137;10737.677869663923;10749.140068794633;10826.783464330512;11012.614558490415;6686.1642294713165;8391.706290280055;8762.474251544927;8802.29581633455;8818.38271321027;8364.498130112213;8516.063233044484;8536.573171341284;8547.102554231717;8553.95723021381;7116.928830711627;7296.270372962661;7319.707211711472;7336.1930187678245;7422.369098626677;7018.929810702032;7091.1490621125795;7194.136703595602;7270.382017528569;7529.435292352986;6684.364985326386;6728;6789.185297764102;6921;7000.334968178015;4736;4751.61987041029;4824.807007719793;4853.466118727008;4965.751712414437;4871.537203965618;4895.143349913822;4994.350734404649;5071.290019397361;5157.226416037624 19:51:55 INFO - PID 3542 | |4;prototype.html;345.033905065816;351.21853875127846;352.92412131391745;359.0968713685082;365.42263224105915;5506.614536982413;5531.115021596535;5539.501444869961;5540.390557038722;5568.638038527498;5379.004884096445;5409.594280428973;5418.729063546826;5418.91871621926;5420.864478388043;3983.900402489932;4086.2236175126777;4097.631213190813;4098.385242213677;4099.795010249491;4117.855875044374;4125.587441255865;4128.855490057834;4131.29767939451;4135.255653982282;4052.2705912935658;4057.7159598828093;4068.9593104069027;4089.1003979124544;4089.8773036808793;4085.3259212229946;4092.1201941582553;4099.959000409987;4100.5899410059055;4100.753954762724;3596.7482276240676;3598.6401359864067;3599.370110230699;3605.2068544920076;3610;5343.118385466393;5349.277847490578;5352.678839269656;5353.732313384354;5391.946080539184;4809.182438985381;4814.387180294605;4825.179719447702;4826.541478559531;4845.3216549683075;5745;5754.280714910637;5757.424257574251;5765.221695071154;5775.711214439303;4023.0948036691802;4025.5370632377358;4027.8590249341423;4038.8586399475876;4044.5146582410007;5843.737031833535;6031.668258245839;6086.2045696519635;6146.200993870812;6160.815175544741;4029.0531725044593;4077.368007958771;4092.3043082676018;4105.568915263914;4110.034141976633;4148.419221309019;4163.146554956226;4169.228692691801;4179.91640167195;4184.811683474251;4779.641526885497;4780.163471392492;4784.497627749106;4791.329213910055;4887.511248875155;5757.222774925415;5775.855603609859;5804.767809287666;5829.708514574254;5843.503302219359;1556.167450414023;1585.69871724372;1587.8650314723147;1588.3805315926797;1599.8320176381544;1042.5204405973186;1090.051655060087;1090.8309212072143;1092.4646923007829;1103.1285284625217;4860.9513904861205;4869.95130048695;4884.8290309838985;4897.8285759998225;4907.411110666671;5892.970535147297;5915.201447804578;5918.852028699231;5925.73334199962;5928.525717942554;4879.56083952446;4899.118158731462;4902.411710594752;4913.631477639191;4919.311296418504;3130.4678204705256;3148.1185268124964;3149.8425078745972;3151.9054428367185;3162.2410621450686;5506.265526359184;5526.336839579276;5529.529989950819;5533.861653458695;5573.804916827891;6055.697215139226;6139.969300153471;6144.5084393248435;6146.4468197861515;6163.674809915889;5544.667319960815;5556;5560.916586251209;5568.025595520849;5578.079616863334;5937.050071988461;5946.6917278198725;5967.37342579023;5978.222831031938;6017.729202185825;5871.236739224044;5876.382979787061;5896.702725400405;5925.111233314865;5927.911081333869;5283.256525346703;5397.649152805055;5454.263674403905;5528.336599608073;5539.781248125406;4427.29163333865;4461.330800379969;4465.397171381822;4484.125595508975;4501.122281155143;5963.4632883039;5964.135200396005;5978.701064946648;5987.550933680079;5997.730102145501;5615.410381909841;5785.363610002981;5792.53659707214;5792.625023740246;5795.652260864362;5791.623544469596;5795.449432303924;5798.710064496842;5807.051205180518;5809.24479817621;5621.8594535136945;5651.728361118716;5678.971605141948;5702.230198923092;5733.541316694571;5786.3056433228285;5810.796622118206;5813.273340832396;5817.418258174149;5830.4461076197695;5603.439656034364;5628.605997580294;5640.182173584889;5656.547476201977;5662.603617746719 19:51:55 INFO - PID 3542 | |5;yui.html;656.763565116558;675.1526833823551;689.937905588497;692.5083190934439;702.3433090060792;12658.746825063505;13055.086143969938;13096.41066152023;14301;15276.618084547892;15228.695426091472;15284.388624455009;15334.233288335594;15394.923025384885;15409.306581203844;807.3420162567503;811.419834818105;815.0382548592688;822.0505316359614;823.3289868756943;796.9322607578334;808.4098608016152;833.7290380626321;835.9916400835974;841.8105926166594;850.8596081646521;855.820277741675;882.9470231786081;889.9955500222522;890.2210565754964;882.7748924024397;883.6377085394957;884.4737381258141;887.5340446265762;890.6036813617943;621.4624349937317;624.4754406298731;644.7292137302344;649.3214590752675;650.1840190560816;14223.146611203258;14371.137731736024;14422.783658245135;14428.639284017878;14441.422343106264;12267.263964162179;12827.102102852805;12852.293123878277;12880.742385152245;12905.2902090385;10933.234673572853;10956.068734157607;11005.284656497382;11208.047315978152;11294.661160165208;2969.569412435185;3008.067499075272;3025.5612936124357;3027.5307327364076;3031.696830316973;85118.57440712818;87075;87382;87858.56070719605;88343;11904.702382440335;12144.210626309261;12173.817392739116;12222.327771972627;12414.441350139265;15766.132862692662;17471.825281747275;20360.592788144153;20490.18039278442;21397.57204855894;6076.453119219292;6267.0286105653695;6273.654948977759;6287.528435367366;6300.495960323163;2769.072360759168;2823.265950852793;2825.293676580855;2827.7455029047483;2828.9858550707113;3009.9548506772417;3595.1191957970464;3703.703703703697;3753;3756.6619004289746;697.8185671725388;709.8793205155137;713.6396119959387;714.989275160873;715.345458905096;522.9581633469313;527.1881302793655;528.8862894477705;530.6259087343414;532.055601307682;10064.949675251577;11172;11698.70753231176;11760.176787624785;12180.390980450942;544.4909010075592;550.243415303957;552.1855263486326;558.1655425139443;559.8432438917109;4350.608445239944;5018.2974383586325;5406;5431.755570999315;5499.010178167968;83363.16636833675;84904;85452;86354;86404.5679771597;70925.64537177385;72723;73004.63497682477;73181;73359.63320183472;63595.68202158959;64107.67946160239;65653;65883.34116658868;67021;10425.113865321533;10639.787204256027;10818.29681070728;11081.889181108085;11199.648073904245;28149.155525334274;28597.571036434056;28760.424791504473;28885.277868052624;29209.70790292155;35944.820275898455;36534.8173259132;36759.81620091882;37152.62847371492;37156.81421592983;12651.746965060463;12769;12865.742685146432;12932.224066556037;13016.349182540645;14613.488527901898;14665.92667036658;14713.705725885637;14764;15112.924435377752;13779.862201378259;13849.723005540034;14268.500602479278;14365;14371.784423233868;14096.718065638835;14334.784978225543;14401.567952961428;14420.134791912518;14444.566663000127;12850.164739291917;13043.347832608142;13090.738185236432;13118.868811311764;13251.072424930162;9902.950485247527;10250.948745256524;10278;10367.27429079957;10454.425006624404;11167.776644466903;11256.831147532957;11491.597794077166;11523.711907202387;11757.647270581896 19:51:55 INFO - PID 3542 | __end_tp_report 19:51:55 INFO - PID 3542 | __start_cc_report 19:51:55 INFO - PID 3542 | _x_x_mozilla_cycle_collect,393 19:51:55 INFO - PID 3542 | __end_cc_report 19:51:55 INFO - PID 3542 | __startTimestamp1496371915083__endTimestamp 19:51:55 INFO - PID 3542 | 19:51:55 INFO - PID 3542 | ------- Summary: start ------- 19:51:55 INFO - PID 3542 | Number of tests: 6 19:51:55 INFO - PID 3542 | 19:51:55 INFO - PID 3542 | [#0] dojo.html Cycles:165 Average:5058.32 Median:5193.38 stddev:591.52 (11.4%) stddev-sans-first:563.33 19:51:55 INFO - PID 3542 | Values: 2687.5 2689.0 2718.1 2724.2 2731.4 4987.2 5076.6 5120.5 5127.5 5153.0 5028.7 5053.4 5113.2 5128.1 5156.0 4598.4 4615.2 4640.7 4641.6 4679.1 4615.1 4647.8 4668.9 4696.0 4740.1 4502.9 4564.0 4625.5 4637.1 4697.1 4530.4 4621.1 4624.6 4645.5 4676.4 4573.4 4592.9 4602.0 4619.3 4631.6 5018.1 5079.8 5164.0 5164.0 5167.8 5491.5 5559.9 5566.6 5600.0 5603.9 5510.3 5519.2 5522.3 5527.4 5528.9 5118.7 5141.7 5151.6 5156.4 5193.4 5456.2 5517.7 5529.6 5637.3 5744.5 5428.7 5431.6 5440.8 5469.4 5488.4 5482.4 5509.5 5517.2 5524.5 5527.8 5387.8 5425.5 5474.5 5493.5 5531.7 5470.7 5536.3 5541.6 5544.3 5546.9 4488.8 4573.0 4582.6 4609.3 4639.9 3910.9 3912.2 3918.8 3949.6 3954.8 4514.9 4563.6 4578.4 4604.1 4651.1 5594.3 5620.5 5621.9 5623.2 5678.1 4671.7 4677.4 4677.8 4687.8 4717.8 4755.4 4816.4 4825.0 4880.0 4892.1 5174.3 5175.4 5201.5 5214.8 5224.1 5430.6 5509.0 5520.6 5562.9 5565.5 5113.0 5125.5 5156.3 5165.6 5168.9 5352.2 5427.9 5436.6 5461.8 5467.6 5604.8 5639.4 5647.3 5648.1 5651.1 5431.9 5434.1 5441.6 5442.2 5482.5 5425.6 5429.0 5437.3 5440.0 5478.2 5118.6 5209.0 5271.4 5353.1 5362.2 5398.9 5410.6 5441.9 5448.6 5450.1 5229.0 5233.7 5249.6 5253.2 5288.4 19:51:55 INFO - PID 3542 | 19:51:55 INFO - PID 3542 | [#1] ext.html Cycles:180 Average:29002.18 Median:2920.24 stddev:39587.01 (1355.6%) stddev-sans-first:39641.04 19:51:55 INFO - PID 3542 | Values: 705.4 729.8 1049.3 1071.9 1182.6 31978.5 32745.7 32793.3 32825.5 32876.0 31358.0 31572.2 31765.2 31785.7 31792.0 6461.7 6499.4 6590.4 6716.6 6730.1 6712.6 6795.5 6801.6 6804.4 6815.7 6696.0 6730.5 6748.1 6795.7 6817.9 6695.9 6751.8 6758.3 6793.7 6806.1 6555.3 6583.6 6610.4 6633.4 6650.2 30090.2 30362.1 30468.4 30480.8 30491.0 2905.7 2915.0 2925.5 2942.1 2976.0 23674.6 23678.2 23780.5 23879.6 23899.6 2831.3 2843.8 2844.2 2850.6 2867.7 141918.0 142289.0 142861.3 143159.0 143234.0 32757.0 33305.0 37454.8 37469.4 39764.0 38710.2 38903.7 38915.8 38962.0 39007.0 11186.7 11305.6 11329.3 11337.5 11342.3 8773.8 8778.2 8786.3 8854.8 8871.5 12210.4 12273.0 12390.2 12396.8 12496.8 5022.7 5148.0 5168.4 5272.2 5290.7 833.6 863.2 883.4 885.1 899.2 19674.8 20666.7 20737.2 21063.0 21137.2 946.3 952.4 953.6 966.1 967.5 10301.8 10437.8 10603.9 10969.8 11040.0 169172.0 169390.0 170081.0 170409.0 170476.0 37338.6 37561.4 38053.6 38087.0 38444.6 1125.1 1181.3 1185.7 1187.8 1193.2 19183.1 20031.7 20602.6 20619.9 21008.2 28077.0 28112.2 28165.4 28167.4 28700.0 146105.0 146661.3 146904.0 147257.0 147348.0 27253.5 27260.5 27841.9 28148.7 28242.3 33979.8 34319.7 34390.0 34423.8 35185.3 24820.5 25939.7 26227.6 27096.0 27335.2 26120.0 26525.0 26872.9 26956.9 27875.7 28678.7 29533.7 29676.0 30031.1 30136.1 25615.7 25630.4 25716.4 26080.9 26778.2 20810.4 21541.6 21666.7 21724.0 21907.3 19:51:55 INFO - PID 3542 | 19:51:55 INFO - PID 3542 | [#2] jquery.html Cycles:180 Average:26370.31 Median:20607.72 stddev:65411.64 (317.4%) stddev-sans-first:65566.07 19:51:55 INFO - PID 3542 | Values: 399.6 407.8 407.9 417.7 419.5 13173.6 13705.9 17263.2 17727.0 17736.8 17906.3 18587.7 18659.6 18692.8 18694.7 5457.4 5640.9 5647.3 5647.9 5656.0 5472.5 5544.4 5546.8 5551.3 5553.1 5529.9 5536.4 5539.1 5541.8 5548.5 5345.5 5373.7 5413.2 5420.4 5431.6 4903.6 4903.9 4905.4 4905.6 4908.0 21290.3 21495.2 21588.5 21604.0 21620.0 1615.0 1664.4 1664.5 1665.8 1667.0 14340.4 14617.3 14822.6 14982.3 15067.2 1827.3 1850.9 1866.6 1902.4 1908.4 88198.6 88921.6 89028.6 89145.0 89831.6 10253.1 10941.8 11011.6 11610.4 11780.9 15464.7 15546.4 15552.1 15624.2 15686.5 7569.5 7585.5 7651.0 7660.2 7759.7 6970.4 6976.7 7016.9 7106.8 7126.4 6742.3 6824.0 6973.5 6984.3 7077.4 1904.5 1974.5 2017.0 2024.5 2148.2 729.7 819.1 851.8 856.0 858.6 16593.0 17090.1 17208.9 17369.4 17554.8 849.5 854.8 864.3 868.2 874.4 9210.5 9400.1 9508.1 9574.3 9690.9 384290.0 389095.0 389200.0 392396.0 403857.0 90403.5 90430.5 91721.5 92762.5 93516.0 986.7 988.3 1021.8 1023.8 1029.1 14346.9 14972.8 15108.5 15506.9 15648.1 40807.6 41033.0 41608.4 41881.8 42219.8 54074.7 54429.5 54780.5 55091.2 55444.4 9054.6 9145.6 9215.0 9251.0 9272.7 14791.6 14846.5 15255.6 15574.5 15843.1 12319.3 12330.6 12372.7 12533.2 12619.9 11360.4 12269.9 12407.1 12433.7 12447.3 12762.9 12840.1 13036.7 13072.7 13090.1 9161.4 9231.9 9245.4 9250.5 9306.2 12691.0 12776.4 12817.2 12824.2 13027.5 19:51:55 INFO - PID 3542 | 19:51:55 INFO - PID 3542 | [#3] mootools.html Cycles:180 Average:5628.49 Median:4525.70 stddev:3548.62 (78.4%) stddev-sans-first:3543.16 19:51:55 INFO - PID 3542 | Values: 1225.9 1302.7 1305.4 1310.8 1323.3 8859.9 9117.6 9246.6 9272.5 9386.3 9289.2 9515.8 9535.4 9544.5 9550.0 1965.5 1990.5 1998.6 2005.7 2007.7 1879.0 1911.1 1924.6 1924.9 1934.6 1938.3 1944.4 1944.6 1947.4 1949.7 1853.4 1871.0 1872.5 1883.2 1887.2 1861.5 1877.8 1917.4 2005.6 2007.2 8891.0 8958.8 8966.7 8967.7 8969.4 4759.5 4944.1 4945.6 4947.7 4968.5 2981.3 3090.7 3118.1 3149.7 3155.6 1021.5 1043.3 1054.6 1065.6 1070.1 11594.4 11957.5 12431.4 12598.2 12619.9 3969.5 4152.5 4158.3 4164.9 4175.7 9950.1 10044.9 10067.9 10078.1 10122.4 4714.0 4754.5 4782.1 4785.5 4808.2 4430.9 4459.4 4506.3 4545.0 4564.9 3572.3 3671.3 3674.6 3721.3 3763.3 1065.4 1065.4 1066.1 1075.0 1077.3 696.3 713.3 713.9 718.2 732.0 5059.7 5135.8 5203.3 5258.5 5358.3 537.1 544.7 548.7 565.1 807.2 3404.6 3455.8 3467.4 3473.7 3558.1 11199.9 11651.9 11873.6 11878.0 11893.5 11701.9 11802.4 11806.0 11884.2 11903.3 6417.9 6477.4 6533.2 6644.5 6664.5 5039.2 5079.4 5284.9 5410.6 5422.4 10396.8 10634.0 10722.4 10728.6 10738.5 9895.8 10737.7 10749.1 10826.8 11012.6 6686.2 8391.7 8762.5 8802.3 8818.4 8364.5 8516.1 8536.6 8547.1 8554.0 7116.9 7296.3 7319.7 7336.2 7422.4 7018.9 7091.1 7194.1 7270.4 7529.4 6684.4 6728.0 6789.2 6921.0 7000.3 4736.0 4751.6 4824.8 4853.5 4965.8 4871.5 4895.1 4994.4 5071.3 5157.2 19:51:55 INFO - PID 3542 | 19:51:55 INFO - PID 3542 | [#4] prototype.html Cycles:180 Average:4759.52 Median:5385.48 stddev:1391.75 (25.8%) stddev-sans-first:1355.64 19:51:55 INFO - PID 3542 | Values: 345.0 351.2 352.9 359.1 365.4 5506.6 5531.1 5539.5 5540.4 5568.6 5379.0 5409.6 5418.7 5418.9 5420.9 3983.9 4086.2 4097.6 4098.4 4099.8 4117.9 4125.6 4128.9 4131.3 4135.3 4052.3 4057.7 4069.0 4089.1 4089.9 4085.3 4092.1 4100.0 4100.6 4100.8 3596.7 3598.6 3599.4 3605.2 3610.0 5343.1 5349.3 5352.7 5353.7 5391.9 4809.2 4814.4 4825.2 4826.5 4845.3 5745.0 5754.3 5757.4 5765.2 5775.7 4023.1 4025.5 4027.9 4038.9 4044.5 5843.7 6031.7 6086.2 6146.2 6160.8 4029.1 4077.4 4092.3 4105.6 4110.0 4148.4 4163.1 4169.2 4179.9 4184.8 4779.6 4780.2 4784.5 4791.3 4887.5 5757.2 5775.9 5804.8 5829.7 5843.5 1556.2 1585.7 1587.9 1588.4 1599.8 1042.5 1090.1 1090.8 1092.5 1103.1 4861.0 4870.0 4884.8 4897.8 4907.4 5893.0 5915.2 5918.9 5925.7 5928.5 4879.6 4899.1 4902.4 4913.6 4919.3 3130.5 3148.1 3149.8 3151.9 3162.2 5506.3 5526.3 5529.5 5533.9 5573.8 6055.7 6140.0 6144.5 6146.4 6163.7 5544.7 5556.0 5560.9 5568.0 5578.1 5937.1 5946.7 5967.4 5978.2 6017.7 5871.2 5876.4 5896.7 5925.1 5927.9 5283.3 5397.6 5454.3 5528.3 5539.8 4427.3 4461.3 4465.4 4484.1 4501.1 5963.5 5964.1 5978.7 5987.6 5997.7 5615.4 5785.4 5792.5 5792.6 5795.7 5791.6 5795.4 5798.7 5807.1 5809.2 5621.9 5651.7 5679.0 5702.2 5733.5 5786.3 5810.8 5813.3 5817.4 5830.4 5603.4 5628.6 5640.2 5656.5 5662.6 19:51:55 INFO - PID 3542 | 19:51:55 INFO - PID 3542 | [#5] yui.html Cycles:180 Average:17072.07 Median:3009.01 stddev:23077.71 (767.0%) stddev-sans-first:23109.53 19:51:55 INFO - PID 3542 | Values: 656.8 675.2 689.9 692.5 702.3 12658.7 13055.1 13096.4 14301.0 15276.6 15228.7 15284.4 15334.2 15394.9 15409.3 807.3 811.4 815.0 822.1 823.3 796.9 808.4 833.7 836.0 841.8 850.9 855.8 882.9 890.0 890.2 882.8 883.6 884.5 887.5 890.6 621.5 624.5 644.7 649.3 650.2 14223.1 14371.1 14422.8 14428.6 14441.4 12267.3 12827.1 12852.3 12880.7 12905.3 10933.2 10956.1 11005.3 11208.0 11294.7 2969.6 3008.1 3025.6 3027.5 3031.7 85118.6 87075.0 87382.0 87858.6 88343.0 11904.7 12144.2 12173.8 12222.3 12414.4 15766.1 17471.8 20360.6 20490.2 21397.6 6076.5 6267.0 6273.7 6287.5 6300.5 2769.1 2823.3 2825.3 2827.7 2829.0 3010.0 3595.1 3703.7 3753.0 3756.7 697.8 709.9 713.6 715.0 715.3 523.0 527.2 528.9 530.6 532.1 10064.9 11172.0 11698.7 11760.2 12180.4 544.5 550.2 552.2 558.2 559.8 4350.6 5018.3 5406.0 5431.8 5499.0 83363.2 84904.0 85452.0 86354.0 86404.6 70925.6 72723.0 73004.6 73181.0 73359.6 63595.7 64107.7 65653.0 65883.3 67021.0 10425.1 10639.8 10818.3 11081.9 11199.6 28149.2 28597.6 28760.4 28885.3 29209.7 35944.8 36534.8 36759.8 37152.6 37156.8 12651.7 12769.0 12865.7 12932.2 13016.3 14613.5 14665.9 14713.7 14764.0 15112.9 13779.9 13849.7 14268.5 14365.0 14371.8 14096.7 14334.8 14401.6 14420.1 14444.6 12850.2 13043.3 13090.7 13118.9 13251.1 9903.0 10250.9 10278.0 10367.3 10454.4 11167.8 11256.8 11491.6 11523.7 11757.6 19:51:55 INFO - PID 3542 | -------- Summary: end -------- 19:51:55 INFO - PID 3542 | 19:51:56 INFO - TEST-INFO | 3542: exit 0 19:51:56 INFO - TEST-OK | dromaeo_css | took 1149954ms 19:51:56 INFO - TEST-START | kraken 19:51:56 INFO - operating with platform_type : linux_ 19:51:56 INFO - Initialising browser for kraken test... 19:51:56 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:36498/getInfo.html -profile /tmp/tmpXu7EpN/profile 19:51:56 INFO - TEST-INFO | started process 3961 (/builds/slave/test/build/application/firefox/firefox http://localhost:36498/getInfo.html) 19:52:31 INFO - TEST-INFO | 3961: killed by SIGTERM 19:52:31 INFO - Browser initialized. 19:52:31 INFO - Running cycle 1/1 for kraken test... 19:52:31 INFO - TEST-INFO | started process 4190 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXu7EpN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:52:43 INFO - PID 4190 | RSS: Main: 188559360 19:52:43 INFO - PID 4190 | 19:52:45 INFO - PID 4190 | Cycle 1(1): loaded http://localhost:36498/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36498/tests/kraken/driver.html?testName=audio-beat-detection) 19:52:46 INFO - PID 4190 | RSS: Main: 191639552 19:52:46 INFO - PID 4190 | 19:52:49 INFO - PID 4190 | Cycle 1(1): loaded http://localhost:36498/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36498/tests/kraken/driver.html?testName=audio-dft) 19:52:50 INFO - PID 4190 | RSS: Main: 190177280 19:52:50 INFO - PID 4190 | 19:52:53 INFO - PID 4190 | Cycle 1(1): loaded http://localhost:36498/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36498/tests/kraken/driver.html?testName=audio-fft) 19:52:53 INFO - PID 4190 | RSS: Main: 185913344 19:52:53 INFO - PID 4190 | 19:52:55 INFO - PID 4190 | Cycle 1(1): loaded http://localhost:36498/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36498/tests/kraken/driver.html?testName=audio-oscillator) 19:52:56 INFO - PID 4190 | RSS: Main: 186298368 19:52:56 INFO - PID 4190 | 19:52:58 INFO - PID 4190 | Cycle 1(1): loaded http://localhost:36498/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36498/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:52:59 INFO - PID 4190 | RSS: Main: 186294272 19:52:59 INFO - PID 4190 | 19:53:02 INFO - PID 4190 | Cycle 1(1): loaded http://localhost:36498/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36498/tests/kraken/driver.html?testName=imaging-darkroom) 19:53:03 INFO - PID 4190 | RSS: Main: 187068416 19:53:03 INFO - PID 4190 | 19:53:06 INFO - PID 4190 | Cycle 1(1): loaded http://localhost:36498/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36498/tests/kraken/driver.html?testName=imaging-desaturate) 19:53:07 INFO - PID 4190 | RSS: Main: 186728448 19:53:07 INFO - PID 4190 | 19:53:10 INFO - PID 4190 | Cycle 1(1): loaded http://localhost:36498/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36498/tests/kraken/driver.html?testName=json-parse-financial) 19:53:10 INFO - PID 4190 | RSS: Main: 187207680 19:53:10 INFO - PID 4190 | 19:53:12 INFO - PID 4190 | Cycle 1(1): loaded http://localhost:36498/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36498/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:53:13 INFO - PID 4190 | RSS: Main: 187047936 19:53:13 INFO - PID 4190 | 19:53:14 INFO - PID 4190 | Cycle 1(1): loaded http://localhost:36498/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36498/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:53:15 INFO - PID 4190 | RSS: Main: 186720256 19:53:15 INFO - PID 4190 | 19:53:17 INFO - PID 4190 | Cycle 1(1): loaded http://localhost:36498/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36498/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:53:18 INFO - PID 4190 | RSS: Main: 186314752 19:53:18 INFO - PID 4190 | 19:53:21 INFO - PID 4190 | Cycle 1(1): loaded http://localhost:36498/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36498/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:53:21 INFO - PID 4190 | RSS: Main: 186617856 19:53:21 INFO - PID 4190 | 19:53:25 INFO - PID 4190 | Cycle 1(1): loaded http://localhost:36498/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36498/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:53:25 INFO - PID 4190 | RSS: Main: 186679296 19:53:25 INFO - PID 4190 | 19:53:27 INFO - PID 4190 | Cycle 1(1): loaded http://localhost:36498/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36498/tests/kraken/driver.html?testName=ai-astar) 19:53:27 INFO - PID 4190 | RSS: Main: 187973632 19:53:27 INFO - PID 4190 | 19:53:27 INFO - PID 4190 | __start_tp_report 19:53:27 INFO - PID 4190 | _x_x_mozilla_page_load 19:53:27 INFO - PID 4190 | _x_x_mozilla_page_load_details 19:53:27 INFO - PID 4190 | |i|pagename|runs| 19:53:27 INFO - PID 4190 | |0;ai-astar;104;113;111;110;111;111;111;111;110;110 19:53:27 INFO - PID 4190 | |1;audio-beat-detection;146;128;123;190;122;123;121;121;147;122 19:53:27 INFO - PID 4190 | |2;audio-dft;163;164;163;167;168;169;167;162;162;163 19:53:27 INFO - PID 4190 | |3;audio-fft;74;74;74;118;74;74;74;75;96;75 19:53:27 INFO - PID 4190 | |4;audio-oscillator;83;84;109;84;84;83;99;83;84;109 19:53:27 INFO - PID 4190 | |5;imaging-gaussian-blur;114;115;113;113;114;114;113;115;119;124 19:53:27 INFO - PID 4190 | |6;imaging-darkroom;152;153;151;152;151;151;150;152;150;150 19:53:27 INFO - PID 4190 | |7;imaging-desaturate;95;95;94;95;95;95;94;94;94;94 19:53:27 INFO - PID 4190 | |8;json-parse-financial;56;53;54;56;60;58;55;57;59;55 19:53:27 INFO - PID 4190 | |9;json-stringify-tinderbox;56;56;57;56;56;57;57;58;56;55 19:53:27 INFO - PID 4190 | |10;stanford-crypto-aes;85;88;87;87;87;85;87;88;119;86 19:53:27 INFO - PID 4190 | |11;stanford-crypto-ccm;131;130;141;129;137;131;135;130;129;147 19:53:27 INFO - PID 4190 | |12;stanford-crypto-pbkdf2;196;189;192;202;192;198;194;188;189;194 19:53:27 INFO - PID 4190 | |13;stanford-crypto-sha256-iterative;73;74;72;71;74;80;77;72;75;71 19:53:27 INFO - PID 4190 | __end_tp_report 19:53:27 INFO - PID 4190 | __start_cc_report 19:53:27 INFO - PID 4190 | _x_x_mozilla_cycle_collect,1039 19:53:27 INFO - PID 4190 | __end_cc_report 19:53:27 INFO - PID 4190 | __startTimestamp1496372007848__endTimestamp 19:53:27 INFO - PID 4190 | 19:53:27 INFO - PID 4190 | ------- Summary: start ------- 19:53:27 INFO - PID 4190 | Number of tests: 14 19:53:27 INFO - PID 4190 | 19:53:27 INFO - PID 4190 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.00 stddev:2.35 (2.1%) stddev-sans-first:0.93 19:53:27 INFO - PID 4190 | Values: 104.0 113.0 111.0 110.0 111.0 111.0 111.0 111.0 110.0 110.0 19:53:27 INFO - PID 4190 | 19:53:27 INFO - PID 4190 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:125.50 stddev:21.99 (17.5%) stddev-sans-first:22.91 19:53:27 INFO - PID 4190 | Values: 146.0 128.0 123.0 190.0 122.0 123.0 121.0 121.0 147.0 122.0 19:53:27 INFO - PID 4190 | 19:53:27 INFO - PID 4190 | [#2] audio-dft Cycles:10 Average:164.80 Median:165.50 stddev:2.66 (1.6%) stddev-sans-first:2.74 19:53:27 INFO - PID 4190 | Values: 163.0 164.0 163.0 167.0 168.0 169.0 167.0 162.0 162.0 163.0 19:53:27 INFO - PID 4190 | 19:53:27 INFO - PID 4190 | [#3] audio-fft Cycles:10 Average:80.80 Median:74.00 stddev:14.76 (19.9%) stddev-sans-first:15.44 19:53:27 INFO - PID 4190 | Values: 74.0 74.0 74.0 118.0 74.0 74.0 74.0 75.0 96.0 75.0 19:53:27 INFO - PID 4190 | 19:53:27 INFO - PID 4190 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:84.00 stddev:11.02 (13.1%) stddev-sans-first:11.38 19:53:27 INFO - PID 4190 | Values: 83.0 84.0 109.0 84.0 84.0 83.0 99.0 83.0 84.0 109.0 19:53:27 INFO - PID 4190 | 19:53:27 INFO - PID 4190 | [#5] imaging-gaussian-blur Cycles:10 Average:115.40 Median:114.50 stddev:3.50 (3.1%) stddev-sans-first:3.68 19:53:27 INFO - PID 4190 | Values: 114.0 115.0 113.0 113.0 114.0 114.0 113.0 115.0 119.0 124.0 19:53:27 INFO - PID 4190 | 19:53:27 INFO - PID 4190 | [#6] imaging-darkroom Cycles:10 Average:151.20 Median:151.50 stddev:1.03 (0.7%) stddev-sans-first:1.05 19:53:27 INFO - PID 4190 | Values: 152.0 153.0 151.0 152.0 151.0 151.0 150.0 152.0 150.0 150.0 19:53:27 INFO - PID 4190 | 19:53:27 INFO - PID 4190 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 19:53:27 INFO - PID 4190 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 94.0 94.0 94.0 94.0 19:53:27 INFO - PID 4190 | 19:53:27 INFO - PID 4190 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.50 stddev:2.21 (3.9%) stddev-sans-first:2.35 19:53:27 INFO - PID 4190 | Values: 56.0 53.0 54.0 56.0 60.0 58.0 55.0 57.0 59.0 55.0 19:53:27 INFO - PID 4190 | 19:53:27 INFO - PID 4190 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:56.50 stddev:0.84 (1.5%) stddev-sans-first:0.88 19:53:27 INFO - PID 4190 | Values: 56.0 56.0 57.0 56.0 56.0 57.0 57.0 58.0 56.0 55.0 19:53:27 INFO - PID 4190 | 19:53:27 INFO - PID 4190 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:87.00 stddev:10.28 (11.8%) stddev-sans-first:10.75 19:53:27 INFO - PID 4190 | Values: 85.0 88.0 87.0 87.0 87.0 85.0 87.0 88.0 119.0 86.0 19:53:27 INFO - PID 4190 | 19:53:27 INFO - PID 4190 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:133.00 stddev:6.04 (4.5%) stddev-sans-first:6.30 19:53:27 INFO - PID 4190 | Values: 131.0 130.0 141.0 129.0 137.0 131.0 135.0 130.0 129.0 147.0 19:53:27 INFO - PID 4190 | 19:53:27 INFO - PID 4190 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.40 Median:194.00 stddev:4.40 (2.3%) stddev-sans-first:4.57 19:53:27 INFO - PID 4190 | Values: 196.0 189.0 192.0 202.0 192.0 198.0 194.0 188.0 189.0 194.0 19:53:27 INFO - PID 4190 | 19:53:27 INFO - PID 4190 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:74.00 stddev:2.85 (3.8%) stddev-sans-first:3.00 19:53:27 INFO - PID 4190 | Values: 73.0 74.0 72.0 71.0 74.0 80.0 77.0 72.0 75.0 71.0 19:53:27 INFO - PID 4190 | -------- Summary: end -------- 19:53:27 INFO - PID 4190 | 19:53:29 INFO - TEST-INFO | 4190: exit 0 19:53:29 INFO - TEST-OK | kraken | took 93104ms 19:53:29 INFO - SUITE-END | took 1243s 19:53:29 INFO - Completed test suite (00:20:43) 19:53:29 INFO - javascript benchmark 19:53:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6564.330947302531, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2687.5162470755263, 2688.9731102688966, 2718.1166121010665, 2724.2235962750615, 2731.4264004559027, 4987.226979818125, 5076.64463487556, 5120.513551212638, 5127.538521533062, 5153.046686363021, 5028.723420211896, 5053.418856831466, 5113.207452844815, 5128.076946149691, 5156.020356132332, 4598.356230127785, 4615.192341340269, 4640.721556706591, 4641.582257596816, 4679.134360143385, 4615.100055489181, 4647.837325693601, 4668.883277918046, 4696.0, 4740.099381117594, 4502.909941801146, 4564.018735971748, 4625.468071171825, 4637.1421287062, 4697.13103075932, 4530.365748795171, 4621.098885717286, 4624.583787459112, 4645.512221216757, 4676.415448068991, 4573.405457290564, 4592.885177870547, 4601.953980460186, 4619.330197121432, 4631.58315751584, 5018.096742586333, 5079.822206222764, 5164.0, 5164.04465173944, 5167.819126330598, 5491.533219676332, 5559.861003474905, 5566.6201951802595, 5600.0, 5603.915941260843, 5510.256115424407, 5519.199716041152, 5522.337319521643, 5527.419620939783, 5528.861778455531, 5118.692878427269, 5141.691498510101, 5151.639385242997, 5156.355455568054, 5193.3767947845745, 5456.181572764038, 5517.69652669107, 5529.585281103933, 5637.295338082739, 5744.540436765049, 5428.67427954324, 5431.592630552725, 5440.782368705287, 5469.398366179717, 5488.396276409591, 5482.424345443671, 5509.47659972302, 5517.200005999108, 5524.502794748492, 5527.806526771544, 5387.757550910218, 5425.511703946585, 5474.479924407175, 5493.533049690821, 5531.668099914018, 5470.72646367688, 5536.335639723259, 5541.5843811714285, 5544.251526043932, 5546.861328466821, 4488.775561221926, 4573.039661671086, 4582.610478109332, 4609.331646911179, 4639.930401043919, 3910.921781564353, 3912.2175564886566, 3918.8236529356245, 3949.585293544194, 3954.8220330085214, 4514.932276015797, 4563.566461186182, 4578.404807375086, 4604.0791841631135, 4651.116287905287, 5594.272744543265, 5620.522255608237, 5621.887562248814, 5623.2408624835125, 5678.14827775837, 4671.719696818202, 4677.4387073550715, 4677.812887484531, 4687.789049492712, 4717.764111794397, 4755.405574303212, 4816.4220293564995, 4824.962633033914, 4880.0, 4892.094962431962, 5174.275601415729, 5175.378954525481, 5201.479852014768, 5214.765335559833, 5224.085784987536, 5430.619856609999, 5509.035918714289, 5520.585956053232, 5562.91655625174, 5565.526930210977, 5113.0, 5125.513076257749, 5156.303898973591, 5165.560927321069, 5168.9483105168465, 5352.170413585901, 5427.891442171213, 5436.592255580768, 5461.808836690856, 5467.58993075513, 5604.8038318658655, 5639.407862174413, 5647.29408823897, 5648.068068768772, 5651.095824668033, 5431.864203394946, 5434.10337294342, 5441.591880608891, 5442.238086667949, 5482.533984611193, 5425.565954723534, 5429.022775900376, 5437.293151890229, 5440.0, 5478.233047373451, 5118.564921981673, 5209.0363282792805, 5271.4464981176425, 5353.063213937623, 5362.195670649434, 5398.9190162146815, 5410.567154627542, 5441.918371224356, 5448.618596698193, 5450.127979523258, 5229.006488767274, 5233.7383130842545, 5249.553787928069, 5253.159494480865, 5288.4182739897815], "value": 5015.874390108401, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.3722187253344, 729.8430837369964, 1049.2602715085861, 1071.8981696738813, 1182.5801840346671, 31978.520322195185, 32745.67254327453, 32793.34413311732, 32825.5076173857, 32876.0, 31358.0, 31572.210694732643, 31765.205869853264, 31785.68214317856, 31792.0, 6461.7415303387925, 6499.38255865692, 6590.406863382294, 6716.597004179765, 6730.125083739107, 6712.630805305706, 6795.524313298071, 6801.591904485722, 6804.3876051155385, 6815.659217039153, 6695.966520167417, 6730.461563074967, 6748.122744043268, 6795.728170873159, 6817.931820681779, 6695.899561506581, 6751.763688270887, 6758.256591774901, 6793.66031698418, 6806.081179040815, 6555.31169227229, 6583.572067815577, 6610.438112760421, 6633.436157926534, 6650.168728908887, 30090.24774380636, 30362.089137325915, 30468.39063218723, 30480.84759576188, 30491.0, 2905.6513218413716, 2914.9562756558457, 2925.531914893607, 2942.102658689099, 2975.9702402976127, 23674.64488032681, 23678.17126400585, 23780.524389512288, 23879.64180537276, 23899.641505377433, 2831.263871393432, 2843.772498200139, 2844.1894060192953, 2850.6151669524766, 2867.698891616371, 141918.0, 142289.0, 142861.28569357086, 143158.99999999895, 143234.0, 32757.0, 33305.0, 37454.81272593619, 37469.437958430644, 39764.0, 38710.2257954845, 38903.665780053285, 38915.80542097271, 38962.0, 39007.0, 11186.720331991603, 11305.604303849326, 11329.263597866113, 11337.489812958436, 11342.319460832376, 8773.780655483664, 8778.209961103532, 8786.297096232285, 8854.822903541894, 8871.512066836256, 12210.389480525939, 12273.0, 12390.194637348544, 12396.81404778929, 12496.81254781179, 5022.74886255693, 5148.0, 5168.3539557555305, 5272.209168624737, 5290.682559046392, 833.5707110837923, 863.210162701134, 883.4346018548134, 885.0927799005941, 899.2131884600974, 19674.803251967583, 20666.689999650018, 20737.163624729474, 21063.0, 21137.154513819583, 946.2855544064188, 952.3999880075646, 953.5661274120258, 966.1304825656965, 967.5210770668564, 10301.793964120825, 10437.843432348522, 10603.893961060445, 10969.83545246822, 11040.0, 169172.0, 169390.0, 170081.0, 170409.0, 170476.0, 37338.62661373351, 37561.43657845134, 38053.61946380556, 38087.0, 38444.61555384466, 1125.0999200639455, 1181.2794195540541, 1185.7450648110525, 1187.7565099154654, 1193.1826698711411, 19183.136758845605, 20031.699524507436, 20602.587948240653, 20619.896900515403, 21008.159673612885, 28077.0, 28112.156635300973, 28165.43669126565, 28167.43665126727, 28700.0, 146105.0, 146661.26669366585, 146904.0, 147257.0, 147348.0, 27253.454930900873, 27260.454790904467, 27841.860790695915, 28148.71851281461, 28242.2939426516, 33979.830100849336, 34319.656803431644, 34390.0, 34423.82788086044, 35185.296294074484, 24820.50358992774, 25939.740602594487, 26227.60658590161, 27096.0, 27335.179944601692, 26120.0, 26525.0, 26872.865635671697, 26956.865215673795, 27875.721242788124, 28678.713212867606, 29533.704662953096, 29676.0, 30031.099067028023, 30136.095917122522, 25615.743842561336, 25630.359241019123, 25716.357091072874, 26080.8695956519, 26778.196654100408, 20810.375688729364, 21541.569168616228, 21666.6749998747, 21724.0, 21907.342779716633], "value": 13882.155916662949, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.6103798796174, 407.8001779128228, 407.85724996251304, 417.65543426672986, 419.50917426610863, 13173.60479185626, 13705.862941370584, 17263.223154958025, 17727.02501362426, 17736.822631773677, 17906.283748650072, 18587.721184182214, 18659.626807463843, 18692.813071869277, 18694.71957920629, 5457.399686034533, 5640.915386269209, 5647.265855438808, 5647.887042259153, 5656.038473459522, 5472.50747432731, 5544.417836127209, 5546.833594992137, 5551.333839939213, 5553.055980483307, 5529.917051244234, 5536.390996990328, 5539.086050801633, 5541.778328866841, 5548.528375088123, 5345.518903298703, 5373.731313434332, 5413.215083812865, 5420.430854760233, 5431.646942948715, 4903.583195428393, 4903.901921961541, 4905.362302900636, 4905.558499735041, 4907.975460122712, 21290.25484108049, 21495.247666331605, 21588.517320508185, 21604.0, 21620.0, 1615.0471221978971, 1664.3592216996544, 1664.525610201099, 1665.758465022577, 1667.0164602884236, 14340.35468403914, 14617.342219600143, 14822.555323340317, 14982.250887455693, 15067.17130557819, 1827.2873579304082, 1850.8982005989665, 1866.6360059788346, 1902.4197619725978, 1908.351160605387, 88198.5590072052, 88921.55539222326, 89028.55485722594, 89145.0, 89831.55084224603, 10253.058085602279, 10941.781164376667, 11011.61459348919, 11610.361430121255, 11780.941095294469, 15464.690706185813, 15546.37814487408, 15552.066875987477, 15624.218789060502, 15686.450974215848, 7569.5079819811535, 7585.544867307979, 7651.0, 7660.1573826879, 7759.728409505753, 6970.442364610819, 6976.7209311627985, 7016.92983070173, 7106.786796396013, 7126.35862772353, 6742.292059333798, 6823.997441125889, 6973.5118541701595, 6984.3364880336285, 7077.372204393018, 1904.5048287445363, 1974.5162435203467, 2016.9798302016793, 2024.514116612032, 2148.2266384101713, 729.7372945739529, 819.1112642782648, 851.7700220940435, 856.032683068129, 858.5964596639569, 16593.0, 17090.145492725314, 17208.913955430144, 17369.392071277445, 17554.824451755576, 849.4521033933079, 854.786303424144, 864.2524216552762, 868.1795703060548, 874.3573473496974, 9210.46062288435, 9400.106989835955, 9508.144267016001, 9574.329796914288, 9690.854637180448, 384290.0, 389095.0, 389200.0, 392396.0, 403857.0, 90403.54798225967, 90430.54784726034, 91721.54139229261, 92762.53618731863, 93516.0, 986.7286496213599, 988.2983082011708, 1021.7752094539189, 1023.8259495885717, 1029.0943969306961, 14346.856531434969, 14972.775408368665, 15108.471203507825, 15506.9224653876, 15648.139352335731, 40807.59192408038, 41033.0, 41608.375874362515, 41881.79059104685, 42219.7889010553, 54074.72962635162, 54429.45570544244, 54780.45219547913, 55091.17363239635, 55444.44555554393, 9054.592543335433, 9145.588448519966, 9215.0, 9251.0, 9272.675456359266, 14791.630209244855, 14846.480373186887, 15255.618609534851, 15574.532764017098, 15843.128627925575, 12319.322437266037, 12330.630081097223, 12372.690682733004, 12533.248005119722, 12619.87380126187, 11360.375179365214, 12269.877301226874, 12407.069469789622, 12433.689157770767, 12447.315397653216, 12762.872371276168, 12840.101192916407, 13036.674083147996, 13072.673183170496, 13090.14914030585, 9161.404508707179, 9231.86152207704, 9245.399049062058, 9250.537473126451, 9306.162445379949, 12691.0, 12776.425060872098, 12817.23096614206, 12824.166429182447, 13027.544035958696], "value": 9068.758331444877, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1225.8528976522816, 1302.6938669412687, 1305.3995162225376, 1310.842698876135, 1323.2986517145914, 8859.911400885998, 9117.635294588208, 9246.630134794601, 9272.53637318134, 9386.29602779791, 9289.163975242227, 9515.762105947337, 9535.427874327544, 9544.475053872035, 9550.044995500446, 1965.4594986378754, 1990.5123244805043, 1998.5703073839122, 2005.6790913453851, 2007.6586980213326, 1878.9906050469797, 1911.0922311901875, 1924.5765931495118, 1924.8845069295817, 1934.6324198402328, 1938.2537722976615, 1944.3680803738841, 1944.6207989442064, 1947.4255094747014, 1949.727038214651, 1853.3883818339982, 1871.017715699262, 1872.522506760781, 1883.1902282018727, 1887.2262372427376, 1861.4508719927653, 1877.7840548336978, 1917.3864363403716, 2005.6289586426412, 2007.197121151551, 8890.955545222298, 8958.776030599221, 8966.686165984225, 8967.686130985385, 8969.372143949926, 4759.50025247351, 4944.110060189165, 4945.579625731817, 4947.653664243504, 4968.478309777457, 2981.254686328418, 3090.6974304143555, 3118.080166350909, 3149.7322727567953, 3155.558221848943, 1021.5403068619152, 1043.3218408034763, 1054.6256079091888, 1065.5737704918017, 1070.122499550369, 11594.362310072942, 11957.461914213794, 12431.440585173688, 12598.181118227378, 12619.873801262054, 3969.4839670842607, 4152.522459917148, 4158.313878210061, 4164.875053748332, 4175.749455032707, 9950.10449059588, 10044.949775251076, 10067.899321006696, 10078.092971632588, 10122.392656440637, 4713.976430117896, 4754.4532378776885, 4782.139214941274, 4785.49752276013, 4808.182608956416, 4430.867073987785, 4459.353393757887, 4506.3465797459185, 4545.045540436479, 4564.931526027112, 3572.3391172633146, 3671.2840996006057, 3674.5669189016303, 3721.2743515014313, 3763.284975854579, 1065.3661071662348, 1065.4353192807823, 1066.0565399621237, 1075.0485820049312, 1077.3105212663902, 696.2932623387265, 713.3045280851233, 713.8679344321317, 718.2063819479505, 731.9707211711578, 5059.696418214919, 5135.794568217304, 5203.271541984125, 5258.474152584711, 5358.303420555303, 537.0601447466933, 544.6595877576515, 548.7064420534995, 565.0873838750471, 807.2250639386255, 3404.5744281964753, 3455.7926524408617, 3467.4452087665854, 3473.6700013498676, 3558.1104723819044, 11199.944000279946, 11651.941740291244, 11873.643790686294, 11878.049756019498, 11893.524259029715, 11701.88298117008, 11802.350870702194, 11805.999999999829, 11884.227525210834, 11903.285802851857, 6417.8716425672155, 6477.4170324671, 6533.216014078341, 6644.534882558271, 6664.466842652576, 5039.193729003342, 5079.415867175175, 5284.947150528599, 5410.621256512007, 5422.427496026108, 10396.792064158826, 10634.0, 10722.356658600509, 10728.624498142528, 10738.516766745672, 9895.802083958137, 10737.677869663923, 10749.140068794633, 10826.783464330512, 11012.614558490415, 6686.1642294713165, 8391.706290280055, 8762.474251544927, 8802.29581633455, 8818.38271321027, 8364.498130112213, 8516.063233044484, 8536.573171341284, 8547.102554231717, 8553.95723021381, 7116.928830711627, 7296.270372962661, 7319.707211711472, 7336.1930187678245, 7422.369098626677, 7018.929810702032, 7091.1490621125795, 7194.136703595602, 7270.382017528569, 7529.435292352986, 6684.364985326386, 6728.0, 6789.185297764102, 6921.0, 7000.334968178015, 4736.0, 4751.61987041029, 4824.807007719793, 4853.466118727008, 4965.751712414437, 4871.537203965618, 4895.143349913822, 4994.350734404649, 5071.290019397361, 5157.226416037624], "value": 4265.433865269817, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.033905065816, 351.21853875127846, 352.92412131391745, 359.0968713685082, 365.42263224105915, 5506.614536982413, 5531.115021596535, 5539.501444869961, 5540.390557038722, 5568.638038527498, 5379.004884096445, 5409.594280428973, 5418.729063546826, 5418.91871621926, 5420.864478388043, 3983.900402489932, 4086.2236175126777, 4097.631213190813, 4098.385242213677, 4099.795010249491, 4117.855875044374, 4125.587441255865, 4128.855490057834, 4131.29767939451, 4135.255653982282, 4052.2705912935658, 4057.7159598828093, 4068.9593104069027, 4089.1003979124544, 4089.8773036808793, 4085.3259212229946, 4092.1201941582553, 4099.959000409987, 4100.5899410059055, 4100.753954762724, 3596.7482276240676, 3598.6401359864067, 3599.370110230699, 3605.2068544920076, 3610.0, 5343.118385466393, 5349.277847490578, 5352.678839269656, 5353.732313384354, 5391.946080539184, 4809.182438985381, 4814.387180294605, 4825.179719447702, 4826.541478559531, 4845.3216549683075, 5745.0, 5754.280714910637, 5757.424257574251, 5765.221695071154, 5775.711214439303, 4023.0948036691802, 4025.5370632377358, 4027.8590249341423, 4038.8586399475876, 4044.5146582410007, 5843.737031833535, 6031.668258245839, 6086.2045696519635, 6146.200993870812, 6160.815175544741, 4029.0531725044593, 4077.368007958771, 4092.3043082676018, 4105.568915263914, 4110.034141976633, 4148.419221309019, 4163.146554956226, 4169.228692691801, 4179.91640167195, 4184.811683474251, 4779.641526885497, 4780.163471392492, 4784.497627749106, 4791.329213910055, 4887.511248875155, 5757.222774925415, 5775.855603609859, 5804.767809287666, 5829.708514574254, 5843.503302219359, 1556.167450414023, 1585.69871724372, 1587.8650314723147, 1588.3805315926797, 1599.8320176381544, 1042.5204405973186, 1090.051655060087, 1090.8309212072143, 1092.4646923007829, 1103.1285284625217, 4860.9513904861205, 4869.95130048695, 4884.8290309838985, 4897.8285759998225, 4907.411110666671, 5892.970535147297, 5915.201447804578, 5918.852028699231, 5925.73334199962, 5928.525717942554, 4879.56083952446, 4899.118158731462, 4902.411710594752, 4913.631477639191, 4919.311296418504, 3130.4678204705256, 3148.1185268124964, 3149.8425078745972, 3151.9054428367185, 3162.2410621450686, 5506.265526359184, 5526.336839579276, 5529.529989950819, 5533.861653458695, 5573.804916827891, 6055.697215139226, 6139.969300153471, 6144.5084393248435, 6146.4468197861515, 6163.674809915889, 5544.667319960815, 5556.0, 5560.916586251209, 5568.025595520849, 5578.079616863334, 5937.050071988461, 5946.6917278198725, 5967.37342579023, 5978.222831031938, 6017.729202185825, 5871.236739224044, 5876.382979787061, 5896.702725400405, 5925.111233314865, 5927.911081333869, 5283.256525346703, 5397.649152805055, 5454.263674403905, 5528.336599608073, 5539.781248125406, 4427.29163333865, 4461.330800379969, 4465.397171381822, 4484.125595508975, 4501.122281155143, 5963.4632883039, 5964.135200396005, 5978.701064946648, 5987.550933680079, 5997.730102145501, 5615.410381909841, 5785.363610002981, 5792.53659707214, 5792.625023740246, 5795.652260864362, 5791.623544469596, 5795.449432303924, 5798.710064496842, 5807.051205180518, 5809.24479817621, 5621.8594535136945, 5651.728361118716, 5678.971605141948, 5702.230198923092, 5733.541316694571, 5786.3056433228285, 5810.796622118206, 5813.273340832396, 5817.418258174149, 5830.4461076197695, 5603.439656034364, 5628.605997580294, 5640.182173584889, 5656.547476201977, 5662.603617746719], "value": 4334.671539395087, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.763565116558, 675.1526833823551, 689.937905588497, 692.5083190934439, 702.3433090060792, 12658.746825063505, 13055.086143969938, 13096.41066152023, 14301.0, 15276.618084547892, 15228.695426091472, 15284.388624455009, 15334.233288335594, 15394.923025384885, 15409.306581203844, 807.3420162567503, 811.419834818105, 815.0382548592688, 822.0505316359614, 823.3289868756943, 796.9322607578334, 808.4098608016152, 833.7290380626321, 835.9916400835974, 841.8105926166594, 850.8596081646521, 855.820277741675, 882.9470231786081, 889.9955500222522, 890.2210565754964, 882.7748924024397, 883.6377085394957, 884.4737381258141, 887.5340446265762, 890.6036813617943, 621.4624349937317, 624.4754406298731, 644.7292137302344, 649.3214590752675, 650.1840190560816, 14223.146611203258, 14371.137731736024, 14422.783658245135, 14428.639284017878, 14441.422343106264, 12267.263964162179, 12827.102102852805, 12852.293123878277, 12880.742385152245, 12905.2902090385, 10933.234673572853, 10956.068734157607, 11005.284656497382, 11208.047315978152, 11294.661160165208, 2969.569412435185, 3008.067499075272, 3025.5612936124357, 3027.5307327364076, 3031.696830316973, 85118.57440712818, 87075.0, 87382.0, 87858.56070719605, 88343.0, 11904.702382440335, 12144.210626309261, 12173.817392739116, 12222.327771972627, 12414.441350139265, 15766.132862692662, 17471.825281747275, 20360.592788144153, 20490.18039278442, 21397.57204855894, 6076.453119219292, 6267.0286105653695, 6273.654948977759, 6287.528435367366, 6300.495960323163, 2769.072360759168, 2823.265950852793, 2825.293676580855, 2827.7455029047483, 2828.9858550707113, 3009.9548506772417, 3595.1191957970464, 3703.703703703697, 3753.0, 3756.6619004289746, 697.8185671725388, 709.8793205155137, 713.6396119959387, 714.989275160873, 715.345458905096, 522.9581633469313, 527.1881302793655, 528.8862894477705, 530.6259087343414, 532.055601307682, 10064.949675251577, 11172.0, 11698.70753231176, 11760.176787624785, 12180.390980450942, 544.4909010075592, 550.243415303957, 552.1855263486326, 558.1655425139443, 559.8432438917109, 4350.608445239944, 5018.2974383586325, 5406.0, 5431.755570999315, 5499.010178167968, 83363.16636833675, 84904.0, 85452.0, 86354.0, 86404.5679771597, 70925.64537177385, 72723.0, 73004.63497682477, 73181.0, 73359.63320183472, 63595.68202158959, 64107.67946160239, 65653.0, 65883.34116658868, 67021.0, 10425.113865321533, 10639.787204256027, 10818.29681070728, 11081.889181108085, 11199.648073904245, 28149.155525334274, 28597.571036434056, 28760.424791504473, 28885.277868052624, 29209.70790292155, 35944.820275898455, 36534.8173259132, 36759.81620091882, 37152.62847371492, 37156.81421592983, 12651.746965060463, 12769.0, 12865.742685146432, 12932.224066556037, 13016.349182540645, 14613.488527901898, 14665.92667036658, 14713.705725885637, 14764.0, 15112.924435377752, 13779.862201378259, 13849.723005540034, 14268.500602479278, 14365.0, 14371.784423233868, 14096.718065638835, 14334.784978225543, 14401.567952961428, 14420.134791912518, 14444.566663000127, 12850.164739291917, 13043.347832608142, 13090.738185236432, 13118.868811311764, 13251.072424930162, 9902.950485247527, 10250.948745256524, 10278.0, 10367.27429079957, 10454.425006624404, 11167.776644466903, 11256.831147532957, 11491.597794077166, 11523.711907202387, 11757.647270581896], "value": 6852.323032044633, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.3000000000004, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 111.0, 110.0, 111.0, 111.0, 111.0, 111.0, 110.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 128.0, 123.0, 190.0, 122.0, 123.0, 121.0, 121.0, 147.0, 122.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 167.0, 168.0, 169.0, 167.0, 162.0, 162.0, 163.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 118.0, 74.0, 74.0, 74.0, 75.0, 96.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 109.0, 84.0, 84.0, 83.0, 99.0, 83.0, 84.0, 109.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 113.0, 113.0, 114.0, 114.0, 113.0, 115.0, 119.0, 124.0], "value": 115.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 153.0, 151.0, 152.0, 151.0, 151.0, 150.0, 152.0, 150.0, 150.0], "value": 151.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 53.0, 54.0, 56.0, 60.0, 58.0, 55.0, 57.0, 59.0, 55.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 56.0, 56.0, 57.0, 57.0, 58.0, 56.0, 55.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 87.0, 87.0, 87.0, 85.0, 87.0, 88.0, 119.0, 86.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 130.0, 141.0, 129.0, 137.0, 131.0, 135.0, 130.0, 129.0, 147.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 189.0, 192.0, 202.0, 192.0, 198.0, 194.0, 188.0, 189.0, 194.0], "value": 193.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 72.0, 71.0, 74.0, 80.0, 77.0, 72.0, 75.0, 71.0], "value": 73.9, "unit": "score"}]}]} 19:53:29 INFO - Return code: 0 19:53:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:53:29 INFO - # TBPL SUCCESS # 19:53:29 INFO - Running post-action listener: _resource_record_post_action 19:53:29 INFO - [mozharness: 2017-06-02 02:53:29.725858Z] Finished run-tests step (success) 19:53:29 INFO - Running post-run listener: _resource_record_post_run 19:53:29 INFO - Total resource usage - Wall time: 1260s; CPU: 13.0%; Read bytes: 8577024; Write bytes: 418172928; Read time: 1700; Write time: 293536 19:53:29 INFO - TinderboxPrint: CPU usage
12.7% 19:53:29 INFO - TinderboxPrint: I/O read bytes / time
8,577,024 / 1,700 19:53:29 INFO - TinderboxPrint: I/O write bytes / time
418,172,928 / 293,536 19:53:29 INFO - TinderboxPrint: CPU idle
8,781.1 (87.3%) 19:53:29 INFO - TinderboxPrint: CPU user
1,219.9 (12.1%) 19:53:29 INFO - TinderboxPrint: Swap in / out
0 / 0 19:53:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 107745280; Read time: 72; Write time: 116980 19:53:29 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 19:53:29 INFO - run-tests - Wall time: 1244s; CPU: 13.0%; Read bytes: 6340608; Write bytes: 310427648; Read time: 1440; Write time: 176556 19:53:30 INFO - Running post-run listener: _upload_blobber_files 19:53:30 INFO - Blob upload gear active. 19:53:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:53:30 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 19:53:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:53:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:53:30 INFO - (blobuploader) - INFO - Open directory for files ... 19:53:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:53:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:53:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:53:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:53:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:53:31 INFO - (blobuploader) - INFO - Done attempting. 19:53:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:53:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:53:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:53:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:53:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:53:32 INFO - (blobuploader) - INFO - Done attempting. 19:53:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:53:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:53:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:53:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:53:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:53:33 INFO - (blobuploader) - INFO - Done attempting. 19:53:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:53:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:53:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:53:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:53:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:53:36 INFO - (blobuploader) - INFO - Done attempting. 19:53:36 INFO - (blobuploader) - INFO - Iteration through files over. 19:53:36 INFO - Return code: 0 19:53:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:53:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:53:36 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9eff496c3403ee1bbc06077fec2b81b5c9fd64875387a52b10fda6506df1804f7979279510675197c907ae233c04c59869a7010f6c3c894e873b14276c7f3c8", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a18fc955df43f5baa962094aa5dab5b4c956d9baab6519f7e295fa650187130e6a4744ddce5fcf955a47c12309ab55b058dfb2e24655512e5be07a242a1181c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c18d409cbe24854752ed484fe0e72745cb3add675b9136a2fd37dae769e7972f0ec43e231469ccd22ec581f6ce07440db2cb12bf3a665badf4620c19d030b3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2b21b0e5ced3c7b71d5ae05ca9ead30c585f7d0bd40ef662f58e1c256e27c72783efc1beda892b4f69d9302c4d4734b6df7cfe3cb1ea646b020fb7314073797"} 19:53:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:53:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:53:36 INFO - Contents: 19:53:36 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9eff496c3403ee1bbc06077fec2b81b5c9fd64875387a52b10fda6506df1804f7979279510675197c907ae233c04c59869a7010f6c3c894e873b14276c7f3c8", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a18fc955df43f5baa962094aa5dab5b4c956d9baab6519f7e295fa650187130e6a4744ddce5fcf955a47c12309ab55b058dfb2e24655512e5be07a242a1181c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c18d409cbe24854752ed484fe0e72745cb3add675b9136a2fd37dae769e7972f0ec43e231469ccd22ec581f6ce07440db2cb12bf3a665badf4620c19d030b3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2b21b0e5ced3c7b71d5ae05ca9ead30c585f7d0bd40ef662f58e1c256e27c72783efc1beda892b4f69d9302c4d4734b6df7cfe3cb1ea646b020fb7314073797"} 19:53:36 INFO - Running post-run listener: copy_logs_to_upload_dir 19:53:36 INFO - Copying logs to upload dir... 19:53:36 INFO - mkdir: /builds/slave/test/build/upload/logs 19:53:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1319.833061 ========= master_lag: 0.20 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2017-06-01 19:53:36.297454) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 19:53:36.300801) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9eff496c3403ee1bbc06077fec2b81b5c9fd64875387a52b10fda6506df1804f7979279510675197c907ae233c04c59869a7010f6c3c894e873b14276c7f3c8", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a18fc955df43f5baa962094aa5dab5b4c956d9baab6519f7e295fa650187130e6a4744ddce5fcf955a47c12309ab55b058dfb2e24655512e5be07a242a1181c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c18d409cbe24854752ed484fe0e72745cb3add675b9136a2fd37dae769e7972f0ec43e231469ccd22ec581f6ce07440db2cb12bf3a665badf4620c19d030b3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2b21b0e5ced3c7b71d5ae05ca9ead30c585f7d0bd40ef662f58e1c256e27c72783efc1beda892b4f69d9302c4d4734b6df7cfe3cb1ea646b020fb7314073797"} build_url:https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011108 build_url: 'https://queue.taskcluster.net/v1/task/Iq4sCn0zRVu1rgKF7Vu6yg/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a9eff496c3403ee1bbc06077fec2b81b5c9fd64875387a52b10fda6506df1804f7979279510675197c907ae233c04c59869a7010f6c3c894e873b14276c7f3c8", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a18fc955df43f5baa962094aa5dab5b4c956d9baab6519f7e295fa650187130e6a4744ddce5fcf955a47c12309ab55b058dfb2e24655512e5be07a242a1181c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8c18d409cbe24854752ed484fe0e72745cb3add675b9136a2fd37dae769e7972f0ec43e231469ccd22ec581f6ce07440db2cb12bf3a665badf4620c19d030b3d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f2b21b0e5ced3c7b71d5ae05ca9ead30c585f7d0bd40ef662f58e1c256e27c72783efc1beda892b4f69d9302c4d4734b6df7cfe3cb1ea646b020fb7314073797"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-01 19:53:36.325099) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 19:53:36.325451) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1496370333.7253-1363543174 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004312 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-01 19:53:36.411038) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 19:53:36.412538) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-01 19:53:36.412893) ========= ========= Total master_lag: 0.36 =========