builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-023 starttime: 1496919110.71 results: success (0) revision: 7efda263a842e60cd0cc00b3c4a7058c65590702 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-06-08 03:51:50.708951) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-06-08 03:51:50.709381) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-08 03:51:50.709653) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-06-08 03:51:50.728313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 03:51:50.728567) ========= 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=6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-06-08 03:51:52-- 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% 46.1M=0s 2017-06-08 03:51:52 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121806 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 03:51:50.863185) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 03:51:50.863485) ========= 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=6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021436 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 03:51:50.915316) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 03:51:50.915630) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 7efda263a842e60cd0cc00b3c4a7058c65590702 --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 7efda263a842e60cd0cc00b3c4a7058c65590702 --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=6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-06-08 03:51:52,744 truncating revision to first 12 chars 2017-06-08 03:51:52,744 Setting DEBUG logging. 2017-06-08 03:51:52,744 attempt 1/10 2017-06-08 03:51:52,744 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/7efda263a842?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-06-08 03:51:53,235 unpacking tar archive at: mozilla-central-7efda263a842/testing/mozharness/ program finished with exit code 0 elapsedTime=0.846244 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 03:51:51.779025) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-08 03:51:51.779346) ========= script_repo_revision: 7efda263a842e60cd0cc00b3c4a7058c65590702 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-06-08 03:51:51.779705) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-08 03:51:51.779983) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-06-08 03:51:51.792228) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 45 secs) (at 2017-06-08 03:51:51.792690) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:51:53 INFO - MultiFileLogger online at 20170608 03:51:53 in /builds/slave/test 03:51:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:51:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:51:53 INFO - {'append_to_log': False, 03:51:53 INFO - 'base_work_dir': '/builds/slave/test', 03:51:53 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:51:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:51:53 INFO - 'branch': 'Firefox-Non-PGO', 03:51:53 INFO - 'buildbot_json_path': 'buildprops.json', 03:51:53 INFO - 'config_files': ('talos/linux_config.py',), 03:51:53 INFO - 'default_actions': ('clobber', 03:51:53 INFO - 'read-buildbot-config', 03:51:53 INFO - 'download-and-extract', 03:51:53 INFO - 'populate-webroot', 03:51:53 INFO - 'create-virtualenv', 03:51:53 INFO - 'install', 03:51:53 INFO - 'setup-mitmproxy', 03:51:53 INFO - 'run-tests'), 03:51:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:51:53 INFO - 'download_minidump_stackwalk': True, 03:51:53 INFO - 'download_symbols': 'ondemand', 03:51:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:51:53 INFO - 'tooltool.py': '/tools/tooltool.py', 03:51:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:51:53 INFO - '/tools/misc-python/virtualenv.py')}, 03:51:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:51:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:51:53 INFO - 'gecko_profile': False, 03:51:53 INFO - 'gecko_profile_interval': 0, 03:51:53 INFO - 'installer_path': 'installer.exe', 03:51:53 INFO - 'log_level': 'info', 03:51:53 INFO - 'log_name': 'talos', 03:51:53 INFO - 'log_to_console': True, 03:51:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:51:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:51:53 INFO - 'opt_config_files': (), 03:51:53 INFO - 'pip_index': False, 03:51:53 INFO - 'suite': 'dromaeojs-e10s', 03:51:53 INFO - 'system_bits': '32', 03:51:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:51:53 INFO - 'title': 'talos-linux64-ix-023', 03:51:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:51:53 INFO - 'use_talos_json': True, 03:51:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:51:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:51:53 INFO - 'work_dir': 'build'} 03:51:53 INFO - [mozharness: 2017-06-08 10:51:53.728307Z] Running clobber step. 03:51:53 INFO - Running pre-action listener: _resource_record_pre_action 03:51:53 INFO - Running main action method: clobber 03:51:53 INFO - rmtree: /builds/slave/test/build 03:51:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:51:55 INFO - Running post-action listener: _resource_record_post_action 03:51:55 INFO - [mozharness: 2017-06-08 10:51:55.261801Z] Finished clobber step (success) 03:51:55 INFO - [mozharness: 2017-06-08 10:51:55.261903Z] Running read-buildbot-config step. 03:51:55 INFO - Running pre-action listener: _resource_record_pre_action 03:51:55 INFO - Running main action method: read_buildbot_config 03:51:55 INFO - Using buildbot properties: 03:51:55 INFO - { 03:51:55 INFO - "project": "", 03:51:55 INFO - "product": "firefox", 03:51:55 INFO - "who": "nobody@mozilla.org", 03:51:55 INFO - "installer_path": "public/build/target.tar.bz2", 03:51:55 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 03:51:55 INFO - "repository": "https://hg.mozilla.org/mozilla-central", 03:51:55 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 03:51:55 INFO - "stage_platform": "linux64", 03:51:55 INFO - "basedir": "/builds/slave/test", 03:51:55 INFO - "buildnumber": 897, 03:51:55 INFO - "platform": "ubuntu64_hw", 03:51:55 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:51:55 INFO - "slavebuilddir": "test", 03:51:55 INFO - "taskId": "TrM5dfUERMORbUr_TeguJw", 03:51:55 INFO - "branch": "mozilla-central", 03:51:55 INFO - "script_repo_revision": "production", 03:51:55 INFO - "revision": "7efda263a842e60cd0cc00b3c4a7058c65590702", 03:51:55 INFO - "slavename": "talos-linux64-ix-023", 03:51:55 INFO - "repo_path": "mozilla-central" 03:51:55 INFO - } 03:51:55 INFO - Finding installer, test and symbols from parent task. 03:51:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TrM5dfUERMORbUr_TeguJw'}, attempt #1 03:51:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TrM5dfUERMORbUr_TeguJw'}, attempt #1 03:51:56 INFO - Task dependencies: QIplsfJJRlOrkuWgUKpF5Q 03:51:56 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q'}, attempt #1 03:51:56 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/target.tar.bz2 03:51:56 INFO - Set test_url: https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/test_packages.json 03:51:56 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/target.crashreporter-symbols.zip 03:51:56 INFO - Running post-action listener: _resource_record_post_action 03:51:56 INFO - [mozharness: 2017-06-08 10:51:56.619642Z] Finished read-buildbot-config step (success) 03:51:56 INFO - [mozharness: 2017-06-08 10:51:56.619865Z] Running download-and-extract step. 03:51:56 INFO - Running pre-action listener: _resource_record_pre_action 03:51:56 INFO - Running main action method: download_and_extract 03:51:56 INFO - mkdir: /builds/slave/test/build/tests 03:51:56 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')]} 03:51:56 INFO - trying https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/target.test_packages.json 03:51:56 INFO - Downloading https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 03:51:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 03:51:57 INFO - Downloaded 989 bytes. 03:51:57 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 03:51:57 INFO - Using the following test package requirements: 03:51:57 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 03:51:57 INFO - u'common': [u'target.common.tests.zip'], 03:51:57 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 03:51:57 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 03:51:57 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 03:51:57 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 03:51:57 INFO - u'mozbase': [u'target.common.tests.zip'], 03:51:57 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 03:51:57 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 03:51:57 INFO - u'web-platform': [u'target.common.tests.zip', 03:51:57 INFO - u'target.web-platform.tests.tar.gz'], 03:51:57 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 03:51:57 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 03:51:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/target.common.tests.zip 03:51:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:51:57 INFO - Fetch https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/target.common.tests.zip into memory 03:51:58 INFO - Content-Length response header: 65738112 03:51:58 INFO - Bytes received: 65738112 03:52:09 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 03:52:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/target.common.tests.zip 03:52:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 03:52:09 INFO - Fetch https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/target.common.tests.zip into memory 03:52:10 INFO - Content-Length response header: 65738112 03:52:10 INFO - Bytes received: 65738112 03:52:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/target.talos.tests.zip 03:52:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:52:22 INFO - Fetch https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/target.talos.tests.zip into memory 03:52:23 INFO - Content-Length response header: 14447563 03:52:23 INFO - Bytes received: 14447563 03:52:23 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')]} 03:52:23 INFO - trying https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/target.tar.bz2 03:52:23 INFO - Downloading https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:52:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:52:24 INFO - Downloaded 59791743 bytes. 03:52:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/target.tar.bz2 03:52:24 INFO - mkdir: /builds/slave/test/properties 03:52:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:52:24 INFO - Writing to file /builds/slave/test/properties/build_url 03:52:24 INFO - Contents: 03:52:24 INFO - build_url:https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/target.tar.bz2 03:52:24 INFO - Running post-action listener: _resource_record_post_action 03:52:24 INFO - Running post-action listener: set_extra_try_arguments 03:52:24 INFO - [mozharness: 2017-06-08 10:52:24.391129Z] Finished download-and-extract step (success) 03:52:24 INFO - [mozharness: 2017-06-08 10:52:24.391227Z] Running populate-webroot step. 03:52:24 INFO - Running pre-action listener: _resource_record_pre_action 03:52:24 INFO - Running main action method: populate_webroot 03:52:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:52:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:52:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:52:24 INFO - '--tppagecycles', 03:52:24 INFO - '7'], 03:52:24 INFO - 'tests': ['tsvgm']}}, 03:52:24 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:52:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:52:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:52:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:52:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:52:24 INFO - 'talos_options': ['--disable-e10s'], 03:52:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:52:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:52:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:52:24 INFO - 'talos_options': ['--disable-e10s'], 03:52:24 INFO - 'tests': ['damp', 'tps']}, 03:52:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:52:24 INFO - 'tests': ['damp', 'tps']}, 03:52:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:52:24 INFO - 'tests': ['dromaeo_dom']}, 03:52:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:52:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:52:24 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:52:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:52:24 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 03:52:24 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 03:52:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:52:24 INFO - 'tests': ['a11yr', 03:52:24 INFO - 'ts_paint', 03:52:24 INFO - 'tpaint', 03:52:24 INFO - 'sessionrestore', 03:52:24 INFO - 'sessionrestore_no_auto_restore', 03:52:24 INFO - 'tabpaint']}, 03:52:24 INFO - 'other-e10s': {'tests': ['a11yr', 03:52:24 INFO - 'ts_paint', 03:52:24 INFO - 'tpaint', 03:52:24 INFO - 'sessionrestore', 03:52:24 INFO - 'sessionrestore_no_auto_restore', 03:52:24 INFO - 'tabpaint']}, 03:52:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:52:24 INFO - 'ts_paint', 03:52:24 INFO - 'tpaint', 03:52:24 INFO - 'sessionrestore', 03:52:24 INFO - 'sessionrestore_no_auto_restore', 03:52:24 INFO - 'tabpaint']}, 03:52:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:52:24 INFO - 'ts_paint', 03:52:24 INFO - 'tpaint', 03:52:24 INFO - 'sessionrestore', 03:52:24 INFO - 'sessionrestore_no_auto_restore', 03:52:24 INFO - 'tabpaint']}, 03:52:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:52:24 INFO - 'tests': ['a11yr', 03:52:24 INFO - 'ts_paint', 03:52:24 INFO - 'tpaint', 03:52:24 INFO - 'sessionrestore', 03:52:24 INFO - 'sessionrestore_no_auto_restore', 03:52:24 INFO - 'tabpaint']}, 03:52:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:52:24 INFO - 'tests': ['a11yr', 03:52:24 INFO - 'ts_paint', 03:52:24 INFO - 'tpaint', 03:52:24 INFO - 'sessionrestore', 03:52:24 INFO - 'sessionrestore_no_auto_restore', 03:52:24 INFO - 'tabpaint']}, 03:52:24 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:52:24 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:52:24 INFO - 'bloom_basic_ref']}, 03:52:24 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set.zip', 03:52:24 INFO - 'talos_options': ['--mitmproxy', 03:52:24 INFO - 'mitmproxy-recording-1.mp', 03:52:24 INFO - '--firstNonBlankPaint'], 03:52:24 INFO - 'tests': ['Quantum_1']}, 03:52:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:52:24 INFO - 'tests': ['tsvgx', 03:52:24 INFO - 'tsvgr_opacity', 03:52:24 INFO - 'tart', 03:52:24 INFO - 'tscrollx', 03:52:24 INFO - 'cart', 03:52:24 INFO - 'tsvg_static']}, 03:52:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:52:24 INFO - 'tsvgr_opacity', 03:52:24 INFO - 'tart', 03:52:24 INFO - 'tscrollx', 03:52:24 INFO - 'cart', 03:52:24 INFO - 'tsvg_static']}, 03:52:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:52:24 INFO - 'talos_options': ['--disable-e10s'], 03:52:24 INFO - 'tests': ['tp5o']}, 03:52:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:52:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:52:24 INFO - 'talos_options': ['--disable-e10s', 03:52:24 INFO - '--xperf_path', 03:52:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:24 INFO - 'tests': ['tp5n']}, 03:52:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:52:24 INFO - 'talos_options': ['--xperf_path', 03:52:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:52:24 INFO - 'tests': ['tp5n']}}, 03:52:24 INFO - 'talos.zip': {'path': '', 03:52:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:52:24 INFO - Running post-action listener: _resource_record_post_action 03:52:24 INFO - [mozharness: 2017-06-08 10:52:24.405639Z] Finished populate-webroot step (success) 03:52:24 INFO - [mozharness: 2017-06-08 10:52:24.405735Z] Running create-virtualenv step. 03:52:24 INFO - Running pre-action listener: _resource_record_pre_action 03:52:24 INFO - Running main action method: create_virtualenv 03:52:24 INFO - Creating virtualenv /builds/slave/test/build/venv 03:52:24 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 03:52:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:52:24 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 03:52:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:52:24 INFO - Using real prefix '/usr' 03:52:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:52:25 INFO - Installing distribute.............................................................................................................................................................................................done. 03:52:26 INFO - Installing pip.................done. 03:52:26 INFO - Return code: 0 03:52:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:52:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:52:27 INFO - Reading from file tmpfile_stdout 03:52:27 INFO - Output received: 03:52:27 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) 03:52:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:52: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')]} 03:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52: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')]} 03:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:27 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 0x13a53b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1721140>, '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 0x1721a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1721ed0>, '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': '6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074', '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 03:52:27 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 03:52:27 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 03:52:27 INFO - Using env: {'DISPLAY': ':0', 03:52:27 INFO - 'HOME': '/home/cltbld', 03:52:27 INFO - 'LANG': 'en_US.UTF-8', 03:52:27 INFO - 'LANGUAGE': 'en_US:en', 03:52:27 INFO - 'LOGNAME': 'cltbld', 03:52:27 INFO - 'MAIL': '/var/mail/cltbld', 03:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:27 INFO - 'MOZ_NO_REMOTE': '1', 03:52:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:27 INFO - 'NO_EM_RESTART': '1', 03:52:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:27 INFO - 'PWD': '/builds/slave/test', 03:52:27 INFO - 'SHELL': '/bin/bash', 03:52:27 INFO - 'SHLVL': '1', 03:52:27 INFO - 'TERM': 'linux', 03:52:27 INFO - 'TMOUT': '86400', 03:52:27 INFO - 'USER': 'cltbld', 03:52:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074', 03:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:27 INFO - '_': '/tools/buildbot/bin/python'} 03:52:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:27 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 03:52:27 INFO - Cleaning up... 03:52:27 INFO - Return code: 0 03:52:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:52: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')]} 03:52:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52: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')]} 03:52:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:27 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 0x13a53b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1721140>, '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 0x1721a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1721ed0>, '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': '6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074', '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 03:52:27 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 03:52:27 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 03:52:27 INFO - Using env: {'DISPLAY': ':0', 03:52:27 INFO - 'HOME': '/home/cltbld', 03:52:27 INFO - 'LANG': 'en_US.UTF-8', 03:52:27 INFO - 'LANGUAGE': 'en_US:en', 03:52:27 INFO - 'LOGNAME': 'cltbld', 03:52:27 INFO - 'MAIL': '/var/mail/cltbld', 03:52:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:27 INFO - 'MOZ_NO_REMOTE': '1', 03:52:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:27 INFO - 'NO_EM_RESTART': '1', 03:52:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:27 INFO - 'PWD': '/builds/slave/test', 03:52:27 INFO - 'SHELL': '/bin/bash', 03:52:27 INFO - 'SHLVL': '1', 03:52:27 INFO - 'TERM': 'linux', 03:52:27 INFO - 'TMOUT': '86400', 03:52:27 INFO - 'USER': 'cltbld', 03:52:27 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074', 03:52:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:27 INFO - '_': '/tools/buildbot/bin/python'} 03:52:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:27 INFO - Downloading/unpacking psutil>=3.1.1 03:52: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 03:52: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 03:52: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 03:52: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 03:52:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:52:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:28 INFO - Installing collected packages: psutil 03:52:28 INFO - Running setup.py install for psutil 03:52:28 INFO - building 'psutil._psutil_linux' extension 03:52:28 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 03:52:29 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 03:52:29 INFO - building 'psutil._psutil_posix' extension 03:52:29 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 03:52:29 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 03:52:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:29 INFO - Successfully installed psutil 03:52:29 INFO - Cleaning up... 03:52:29 INFO - Return code: 0 03:52:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:52: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')]} 03:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52: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')]} 03:52:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13a53b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1721140>, '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 0x1721a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1721ed0>, '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': '6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074', '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 03:52: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:52: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 mozsystemmonitor==0.3 03:52:29 INFO - Using env: {'DISPLAY': ':0', 03:52:29 INFO - 'HOME': '/home/cltbld', 03:52:29 INFO - 'LANG': 'en_US.UTF-8', 03:52:29 INFO - 'LANGUAGE': 'en_US:en', 03:52:29 INFO - 'LOGNAME': 'cltbld', 03:52:29 INFO - 'MAIL': '/var/mail/cltbld', 03:52:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:29 INFO - 'MOZ_NO_REMOTE': '1', 03:52:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:29 INFO - 'NO_EM_RESTART': '1', 03:52:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:29 INFO - 'PWD': '/builds/slave/test', 03:52:29 INFO - 'SHELL': '/bin/bash', 03:52:29 INFO - 'SHLVL': '1', 03:52:29 INFO - 'TERM': 'linux', 03:52:29 INFO - 'TMOUT': '86400', 03:52:29 INFO - 'USER': 'cltbld', 03:52:29 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074', 03:52:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:29 INFO - '_': '/tools/buildbot/bin/python'} 03:52:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:52:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:52:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:52:30 INFO - Installing collected packages: mozsystemmonitor 03:52:30 INFO - Running setup.py install for mozsystemmonitor 03:52:30 INFO - Successfully installed mozsystemmonitor 03:52:30 INFO - Cleaning up... 03:52:30 INFO - Return code: 0 03:52:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13a53b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1721140>, '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 0x1721a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1721ed0>, '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': '6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074', '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 03:52:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:52:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:52:30 INFO - Using env: {'DISPLAY': ':0', 03:52:30 INFO - 'HOME': '/home/cltbld', 03:52:30 INFO - 'LANG': 'en_US.UTF-8', 03:52:30 INFO - 'LANGUAGE': 'en_US:en', 03:52:30 INFO - 'LOGNAME': 'cltbld', 03:52:30 INFO - 'MAIL': '/var/mail/cltbld', 03:52:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:30 INFO - 'MOZ_NO_REMOTE': '1', 03:52:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:30 INFO - 'NO_EM_RESTART': '1', 03:52:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:30 INFO - 'PWD': '/builds/slave/test', 03:52:30 INFO - 'SHELL': '/bin/bash', 03:52:30 INFO - 'SHLVL': '1', 03:52:30 INFO - 'TERM': 'linux', 03:52:30 INFO - 'TMOUT': '86400', 03:52:30 INFO - 'USER': 'cltbld', 03:52:30 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074', 03:52:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:30 INFO - '_': '/tools/buildbot/bin/python'} 03:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:31 INFO - Downloading/unpacking jsonschema==2.5.1 03:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:52:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:32 INFO - Downloading functools32-3.2.3-2.tar.gz 03:52:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:52:32 INFO - warning: no files found matching '*.txt' 03:52:32 INFO - no previously-included directories found matching 'build' 03:52:32 INFO - no previously-included directories found matching 'dist' 03:52:32 INFO - no previously-included directories found matching '.git*' 03:52:32 INFO - Installing collected packages: jsonschema, functools32 03:52:32 INFO - Running setup.py install for functools32 03:52:32 INFO - warning: no files found matching '*.txt' 03:52:32 INFO - no previously-included directories found matching 'build' 03:52:32 INFO - no previously-included directories found matching 'dist' 03:52:32 INFO - no previously-included directories found matching '.git*' 03:52:32 INFO - Successfully installed jsonschema functools32 03:52:32 INFO - Cleaning up... 03:52:32 INFO - Return code: 0 03:52:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13a53b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1721140>, '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 0x1721a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1721ed0>, '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': '6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074', '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 03:52:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:52:32 INFO - Using env: {'DISPLAY': ':0', 03:52:32 INFO - 'HOME': '/home/cltbld', 03:52:32 INFO - 'LANG': 'en_US.UTF-8', 03:52:32 INFO - 'LANGUAGE': 'en_US:en', 03:52:32 INFO - 'LOGNAME': 'cltbld', 03:52:32 INFO - 'MAIL': '/var/mail/cltbld', 03:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:32 INFO - 'MOZ_NO_REMOTE': '1', 03:52:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:32 INFO - 'NO_EM_RESTART': '1', 03:52:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:32 INFO - 'PWD': '/builds/slave/test', 03:52:32 INFO - 'SHELL': '/bin/bash', 03:52:32 INFO - 'SHLVL': '1', 03:52:32 INFO - 'TERM': 'linux', 03:52:32 INFO - 'TMOUT': '86400', 03:52:32 INFO - 'USER': 'cltbld', 03:52:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074', 03:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:32 INFO - '_': '/tools/buildbot/bin/python'} 03:52:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:52:32 INFO - Cleaning up... 03:52:32 INFO - Return code: 0 03:52:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13a53b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1721140>, '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 0x1721a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1721ed0>, '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': '6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074', '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 03:52:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:52:32 INFO - Using env: {'DISPLAY': ':0', 03:52:32 INFO - 'HOME': '/home/cltbld', 03:52:32 INFO - 'LANG': 'en_US.UTF-8', 03:52:32 INFO - 'LANGUAGE': 'en_US:en', 03:52:32 INFO - 'LOGNAME': 'cltbld', 03:52:32 INFO - 'MAIL': '/var/mail/cltbld', 03:52:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:32 INFO - 'MOZ_NO_REMOTE': '1', 03:52:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:32 INFO - 'NO_EM_RESTART': '1', 03:52:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:32 INFO - 'PWD': '/builds/slave/test', 03:52:32 INFO - 'SHELL': '/bin/bash', 03:52:32 INFO - 'SHLVL': '1', 03:52:32 INFO - 'TERM': 'linux', 03:52:32 INFO - 'TMOUT': '86400', 03:52:32 INFO - 'USER': 'cltbld', 03:52:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074', 03:52:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:32 INFO - '_': '/tools/buildbot/bin/python'} 03:52:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:32 INFO - Downloading/unpacking blobuploader==1.2.4 03:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:34 INFO - Downloading blobuploader-1.2.4.tar.gz 03:52:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:52:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:52:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:34 INFO - Downloading docopt-0.6.1.tar.gz 03:52:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:52:34 INFO - Installing collected packages: blobuploader, requests, docopt 03:52:34 INFO - Running setup.py install for blobuploader 03:52:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:52:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:52:34 INFO - Running setup.py install for requests 03:52:35 INFO - Running setup.py install for docopt 03:52:35 INFO - Successfully installed blobuploader requests docopt 03:52:35 INFO - Cleaning up... 03:52:35 INFO - Return code: 0 03:52:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:35 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 0x13a53b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1721140>, '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 0x1721a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1721ed0>, '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': '6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074', '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 03:52:35 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 03:52:35 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 03:52:35 INFO - Using env: {'DISPLAY': ':0', 03:52:35 INFO - 'HOME': '/home/cltbld', 03:52:35 INFO - 'LANG': 'en_US.UTF-8', 03:52:35 INFO - 'LANGUAGE': 'en_US:en', 03:52:35 INFO - 'LOGNAME': 'cltbld', 03:52:35 INFO - 'MAIL': '/var/mail/cltbld', 03:52:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:35 INFO - 'MOZ_NO_REMOTE': '1', 03:52:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:35 INFO - 'NO_EM_RESTART': '1', 03:52:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:35 INFO - 'PWD': '/builds/slave/test', 03:52:35 INFO - 'SHELL': '/bin/bash', 03:52:35 INFO - 'SHLVL': '1', 03:52:35 INFO - 'TERM': 'linux', 03:52:35 INFO - 'TMOUT': '86400', 03:52:35 INFO - 'USER': 'cltbld', 03:52:35 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074', 03:52:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:35 INFO - '_': '/tools/buildbot/bin/python'} 03:52:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:35 INFO - Running setup.py (path:/tmp/pip-VeBGyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:35 INFO - Running setup.py (path:/tmp/pip-ocW5xp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:35 INFO - Running setup.py (path:/tmp/pip-Wus2No-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:35 INFO - Running setup.py (path:/tmp/pip-jpQxWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:35 INFO - Running setup.py (path:/tmp/pip-CMyldO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:35 INFO - Running setup.py (path:/tmp/pip-HFPEMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:35 INFO - Running setup.py (path:/tmp/pip-il6OpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:35 INFO - Running setup.py (path:/tmp/pip-tTOGI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:36 INFO - Running setup.py (path:/tmp/pip-1jSEg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:36 INFO - Running setup.py (path:/tmp/pip-Jhk0bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:36 INFO - Running setup.py (path:/tmp/pip-MwNHbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:36 INFO - Running setup.py (path:/tmp/pip-1MeTdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:36 INFO - Running setup.py (path:/tmp/pip-dzEAhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:36 INFO - Running setup.py (path:/tmp/pip-u3AVXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:36 INFO - Running setup.py (path:/tmp/pip-6zcOop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:36 INFO - Running setup.py (path:/tmp/pip-S9hP3S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:36 INFO - Running setup.py (path:/tmp/pip-Cqm9uS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:52:36 INFO - Running setup.py install for manifestparser 03:52:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:52:36 INFO - Running setup.py install for mozcrash 03:52:36 INFO - Running setup.py install for mozdebug 03:52:36 INFO - Running setup.py install for mozdevice 03:52:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:52:37 INFO - Running setup.py install for mozfile 03:52:37 INFO - Running setup.py install for mozhttpd 03:52:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:52:37 INFO - Running setup.py install for mozinfo 03:52:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:52:37 INFO - Running setup.py install for mozInstall 03:52:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:52:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:52:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:52:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:52:37 INFO - Running setup.py install for mozleak 03:52:37 INFO - Running setup.py install for mozlog 03:52:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:52:37 INFO - Running setup.py install for moznetwork 03:52:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:52:37 INFO - Running setup.py install for mozprocess 03:52:37 INFO - Running setup.py install for mozprofile 03:52:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:52:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:52:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:52:38 INFO - Running setup.py install for mozrunner 03:52:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:52:38 INFO - Running setup.py install for mozscreenshot 03:52:38 INFO - Running setup.py install for moztest 03:52:38 INFO - Running setup.py install for mozversion 03:52:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:52:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:52:38 INFO - Cleaning up... 03:52:38 INFO - Return code: 0 03:52:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:38 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 0x13a53b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1721140>, '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 0x1721a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1721ed0>, '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': '6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074', '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 03:52:38 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 03:52:38 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 03:52:38 INFO - Using env: {'DISPLAY': ':0', 03:52:38 INFO - 'HOME': '/home/cltbld', 03:52:38 INFO - 'LANG': 'en_US.UTF-8', 03:52:38 INFO - 'LANGUAGE': 'en_US:en', 03:52:38 INFO - 'LOGNAME': 'cltbld', 03:52:38 INFO - 'MAIL': '/var/mail/cltbld', 03:52:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:38 INFO - 'MOZ_NO_REMOTE': '1', 03:52:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:38 INFO - 'NO_EM_RESTART': '1', 03:52:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:38 INFO - 'PWD': '/builds/slave/test', 03:52:38 INFO - 'SHELL': '/bin/bash', 03:52:38 INFO - 'SHLVL': '1', 03:52:38 INFO - 'TERM': 'linux', 03:52:38 INFO - 'TMOUT': '86400', 03:52:38 INFO - 'USER': 'cltbld', 03:52:38 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074', 03:52:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:38 INFO - '_': '/tools/buildbot/bin/python'} 03:52:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:38 INFO - Running setup.py (path:/tmp/pip-OS6faT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:38 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)) 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:38 INFO - Running setup.py (path:/tmp/pip-Ds67_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:38 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)) 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:38 INFO - Running setup.py (path:/tmp/pip-jOOXIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:38 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)) 03:52:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:38 INFO - Running setup.py (path:/tmp/pip-ovwoHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:39 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)) 03:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:39 INFO - Running setup.py (path:/tmp/pip-gpSVeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:39 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)) 03:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:39 INFO - Running setup.py (path:/tmp/pip-_TxLRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:39 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)) 03:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:39 INFO - Running setup.py (path:/tmp/pip-nAmWYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:39 INFO - Running setup.py (path:/tmp/pip-_PHYDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:39 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)) 03:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:39 INFO - Running setup.py (path:/tmp/pip-Bi4oie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:39 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)) 03:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:39 INFO - Running setup.py (path:/tmp/pip-O0GjJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:39 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)) 03:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:39 INFO - Running setup.py (path:/tmp/pip-lehLA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:39 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)) 03:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:39 INFO - Running setup.py (path:/tmp/pip-MB6KPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:39 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)) 03:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:39 INFO - Running setup.py (path:/tmp/pip-gkIgDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:39 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)) 03:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:39 INFO - Running setup.py (path:/tmp/pip-7zXbZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:39 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)) 03:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:39 INFO - Running setup.py (path:/tmp/pip-ZTHY6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:39 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)) 03:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:39 INFO - Running setup.py (path:/tmp/pip-voHa9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:39 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)) 03:52:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:39 INFO - Running setup.py (path:/tmp/pip-vfSVCj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:39 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)) 03:52:39 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)) 03:52:39 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)) 03:52:39 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)) 03:52:39 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)) 03:52:39 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)) 03:52:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:41 INFO - Downloading blessings-1.6.tar.gz 03:52:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:52:41 INFO - Installing collected packages: blessings 03:52:41 INFO - Running setup.py install for blessings 03:52:41 INFO - Successfully installed blessings 03:52:41 INFO - Cleaning up... 03:52:41 INFO - Return code: 0 03:52:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:52:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:52:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:52:41 INFO - Reading from file tmpfile_stdout 03:52:41 INFO - Current package versions: 03:52:41 INFO - argparse == 1.2.1 03:52:41 INFO - blessings == 1.6 03:52:41 INFO - blobuploader == 1.2.4 03:52:41 INFO - docopt == 0.6.1 03:52:41 INFO - functools32 == 3.2.3-2 03:52:41 INFO - jsonschema == 2.5.1 03:52:41 INFO - manifestparser == 1.1 03:52:41 INFO - mozInstall == 1.12 03:52:41 INFO - mozcrash == 1.0 03:52:41 INFO - mozdebug == 0.1 03:52:41 INFO - mozdevice == 0.51 03:52:41 INFO - mozfile == 1.2 03:52:41 INFO - mozhttpd == 0.7 03:52:41 INFO - mozinfo == 0.10 03:52:41 INFO - mozleak == 0.1 03:52:41 INFO - mozlog == 3.4 03:52:41 INFO - moznetwork == 0.27 03:52:41 INFO - mozprocess == 0.25 03:52:41 INFO - mozprofile == 0.28 03:52:41 INFO - mozrunner == 6.13 03:52:41 INFO - mozscreenshot == 0.1 03:52:41 INFO - mozsystemmonitor == 0.3 03:52:41 INFO - moztest == 0.8 03:52:41 INFO - mozversion == 1.4 03:52:41 INFO - psutil == 3.1.1 03:52:41 INFO - requests == 1.2.3 03:52:41 INFO - wsgiref == 0.1.2 03:52:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:41 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')]} 03:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:41 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')]} 03:52:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:41 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 0x13a53b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1721140>, '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 0x1721a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1721ed0>, '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': '6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074', '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 03:52:41 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 03:52:41 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 03:52:41 INFO - Using env: {'DISPLAY': ':0', 03:52:41 INFO - 'HOME': '/home/cltbld', 03:52:41 INFO - 'LANG': 'en_US.UTF-8', 03:52:41 INFO - 'LANGUAGE': 'en_US:en', 03:52:41 INFO - 'LOGNAME': 'cltbld', 03:52:41 INFO - 'MAIL': '/var/mail/cltbld', 03:52:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:41 INFO - 'MOZ_NO_REMOTE': '1', 03:52:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:41 INFO - 'NO_EM_RESTART': '1', 03:52:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:41 INFO - 'PWD': '/builds/slave/test', 03:52:41 INFO - 'SHELL': '/bin/bash', 03:52:41 INFO - 'SHLVL': '1', 03:52:41 INFO - 'TERM': 'linux', 03:52:41 INFO - 'TMOUT': '86400', 03:52:41 INFO - 'USER': 'cltbld', 03:52:41 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074', 03:52:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:41 INFO - '_': '/tools/buildbot/bin/python'} 03:52:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:41 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)) 03:52:41 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)) 03:52:41 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)) 03:52:41 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)) 03:52:41 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)) 03:52:41 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)) 03:52:41 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)) 03:52:41 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)) 03:52:41 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)) 03:52:41 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 03:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:42 INFO - Downloading marionette_driver-1.4.0.tar.gz 03:52:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 03:52:42 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)) 03:52:42 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)) 03:52:42 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)) 03:52:42 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)) 03:52:42 INFO - Installing collected packages: marionette-driver 03:52:42 INFO - Running setup.py install for marionette-driver 03:52:43 INFO - Successfully installed marionette-driver 03:52:43 INFO - Cleaning up... 03:52:43 INFO - Return code: 0 03:52:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:43 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 0x13a53b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x157fa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17239a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1721140>, '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 0x1721a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1721ed0>, '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': '6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074', '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 03:52:43 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 03:52:43 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 03:52:43 INFO - Using env: {'DISPLAY': ':0', 03:52:43 INFO - 'HOME': '/home/cltbld', 03:52:43 INFO - 'LANG': 'en_US.UTF-8', 03:52:43 INFO - 'LANGUAGE': 'en_US:en', 03:52:43 INFO - 'LOGNAME': 'cltbld', 03:52:43 INFO - 'MAIL': '/var/mail/cltbld', 03:52:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:43 INFO - 'MOZ_NO_REMOTE': '1', 03:52:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:52:43 INFO - 'NO_EM_RESTART': '1', 03:52:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:52:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:43 INFO - 'PWD': '/builds/slave/test', 03:52:43 INFO - 'SHELL': '/bin/bash', 03:52:43 INFO - 'SHLVL': '1', 03:52:43 INFO - 'TERM': 'linux', 03:52:43 INFO - 'TMOUT': '86400', 03:52:43 INFO - 'USER': 'cltbld', 03:52:43 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074', 03:52:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:43 INFO - '_': '/tools/buildbot/bin/python'} 03:52:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:52:43 INFO - Cleaning up... 03:52:43 INFO - Return code: 0 03:52:43 INFO - Running post-action listener: _resource_record_post_action 03:52:43 INFO - Running post-action listener: _start_resource_monitoring 03:52:43 INFO - Starting resource monitoring. 03:52:43 INFO - [mozharness: 2017-06-08 10:52:43.293077Z] Finished create-virtualenv step (success) 03:52:43 INFO - [mozharness: 2017-06-08 10:52:43.293605Z] Running install step. 03:52:43 INFO - Running pre-action listener: _resource_record_pre_action 03:52:43 INFO - Running main action method: install 03:52:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:52:43 INFO - Reading from file tmpfile_stdout 03:52:43 INFO - Detecting whether we're running mozinstall >=1.0... 03:52:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:52:43 INFO - Reading from file tmpfile_stdout 03:52:43 INFO - Output received: 03:52:43 INFO - Usage: mozinstall [options] installer 03:52:43 INFO - Options: 03:52:43 INFO - -h, --help show this help message and exit 03:52:43 INFO - -d DEST, --destination=DEST 03:52:43 INFO - Directory to install application into. [default: 03:52:43 INFO - "/builds/slave/test"] 03:52:43 INFO - --app=APP Application being installed. [default: firefox] 03:52:43 INFO - mkdir: /builds/slave/test/build/application 03:52:43 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'] 03:52:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:53:00 INFO - Reading from file tmpfile_stdout 03:53:00 INFO - Output received: 03:53:00 INFO - /builds/slave/test/build/application/firefox/firefox 03:53:00 INFO - Running post-action listener: _resource_record_post_action 03:53:00 INFO - [mozharness: 2017-06-08 10:53:00.481527Z] Finished install step (success) 03:53:00 INFO - [mozharness: 2017-06-08 10:53:00.481808Z] Running setup-mitmproxy step. 03:53:00 INFO - Running pre-action listener: _resource_record_pre_action 03:53:00 INFO - Running main action method: setup_mitmproxy 03:53:00 INFO - Skipping: mitmproxy is not required 03:53:00 INFO - Running post-action listener: _resource_record_post_action 03:53:00 INFO - [mozharness: 2017-06-08 10:53:00.482956Z] Finished setup-mitmproxy step (success) 03:53:00 INFO - [mozharness: 2017-06-08 10:53:00.483179Z] Running run-tests step. 03:53:00 INFO - Running pre-action listener: _resource_record_pre_action 03:53:00 INFO - Running main action method: run_tests 03:53:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:53:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:53:00 INFO - Python 2.7.3 03:53:00 INFO - Return code: 0 03:53:00 INFO - grabbing minidump binary from tooltool 03:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:53:00 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 0x1721140>, '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 0x1721a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1721ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:53:00 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 03:53:00 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 03:53:00 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 03:53:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:53:00 INFO - Return code: 0 03:53:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:53:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:53:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:53:00 INFO - ENV: RUST_BACKTRACE is now 1 03:53:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:53:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:53:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 03:53:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 03:53:00 INFO - Using env: {'DISPLAY': ':0', 03:53:00 INFO - 'HOME': '/home/cltbld', 03:53:00 INFO - 'LANG': 'en_US.UTF-8', 03:53:00 INFO - 'LANGUAGE': 'en_US:en', 03:53:00 INFO - 'LOGNAME': 'cltbld', 03:53:00 INFO - 'MAIL': '/var/mail/cltbld', 03:53:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:53:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:53:00 INFO - 'MOZ_NO_REMOTE': '1', 03:53:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:53:00 INFO - 'NO_EM_RESTART': '1', 03:53:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:53:00 INFO - 'PWD': '/builds/slave/test', 03:53:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:53:00 INFO - 'RUST_BACKTRACE': '1', 03:53:00 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 03:53:00 INFO - 'SHELL': '/bin/bash', 03:53:00 INFO - 'SHLVL': '1', 03:53:00 INFO - 'TERM': 'linux', 03:53:00 INFO - 'TMOUT': '86400', 03:53:00 INFO - 'USER': 'cltbld', 03:53:00 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074', 03:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:53:00 INFO - '_': '/tools/buildbot/bin/python'} 03:53:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 03:53:00 INFO - mozversion application_buildid: 20170608100220 03:53:00 INFO - mozversion application_changeset: 7efda263a842e60cd0cc00b3c4a7058c65590702 03:53:00 INFO - mozversion application_display_name: Nightly 03:53:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:53:00 INFO - mozversion application_name: Firefox 03:53:00 INFO - mozversion application_remotingname: firefox 03:53:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:53:00 INFO - mozversion application_vendor: Mozilla 03:53:00 INFO - mozversion application_version: 55.0a1 03:53:00 INFO - mozversion platform_buildid: 20170608100220 03:53:00 INFO - mozversion platform_changeset: 7efda263a842e60cd0cc00b3c4a7058c65590702 03:53:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:53:00 INFO - mozversion platform_version: 55.0a1 03:53:00 INFO - using testdate: 1496919180 03:53:00 INFO - actual date: 1496919180 03:53:00 INFO - starting webserver on 'localhost:59012' 03:53:00 INFO - SUITE-START | Running 2 tests 03:53:00 INFO - TEST-START | dromaeo_css 03:53:00 INFO - operating with platform_type : linux_ 03:53:00 INFO - Initialising browser for dromaeo_css test... 03:53:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59012/getInfo.html -profile /tmp/tmp0eOHiC/profile 03:53:00 INFO - TEST-INFO | started process 12791 (/builds/slave/test/build/application/firefox/firefox http://localhost:59012/getInfo.html) 03:53:35 INFO - TEST-INFO | 12791: killed by SIGTERM 03:53:35 INFO - Browser initialized. 03:53:35 INFO - Running cycle 1/1 for dromaeo_css test... 03:53:35 INFO - TEST-INFO | started process 12997 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0eOHiC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:53:46 INFO - PID 12997 | RSS: Main: 177696768 03:53:46 INFO - PID 12997 | 03:56:46 INFO - PID 12997 | Cycle 1(1): loaded http://localhost:59012/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59012/tests/dromaeo/cssquery-ext.html) 03:56:47 INFO - PID 12997 | RSS: Main: 174407680 03:56:47 INFO - PID 12997 | 03:59:49 INFO - PID 12997 | Cycle 1(1): loaded http://localhost:59012/tests/dromaeo/cssquery-ext.html (next: http://localhost:59012/tests/dromaeo/cssquery-jquery.html) 03:59:50 INFO - PID 12997 | RSS: Main: 179499008 03:59:50 INFO - PID 12997 | 04:02:51 INFO - PID 12997 | Cycle 1(1): loaded http://localhost:59012/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59012/tests/dromaeo/cssquery-mootools.html) 04:02:52 INFO - PID 12997 | RSS: Main: 177000448 04:02:52 INFO - PID 12997 | 04:05:54 INFO - PID 12997 | Cycle 1(1): loaded http://localhost:59012/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59012/tests/dromaeo/cssquery-prototype.html) 04:05:54 INFO - PID 12997 | RSS: Main: 180822016 04:05:54 INFO - PID 12997 | 04:08:57 INFO - PID 12997 | Cycle 1(1): loaded http://localhost:59012/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59012/tests/dromaeo/cssquery-yui.html) 04:08:57 INFO - PID 12997 | RSS: Main: 179601408 04:08:57 INFO - PID 12997 | 04:11:59 INFO - PID 12997 | Cycle 1(1): loaded http://localhost:59012/tests/dromaeo/cssquery-yui.html (next: http://localhost:59012/tests/dromaeo/cssquery-dojo.html) 04:11:59 INFO - PID 12997 | RSS: Main: 180154368 04:11:59 INFO - PID 12997 | 04:11:59 INFO - PID 12997 | __start_tp_report 04:11:59 INFO - PID 12997 | _x_x_mozilla_page_load 04:11:59 INFO - PID 12997 | _x_x_mozilla_page_load_details 04:11:59 INFO - PID 12997 | |i|pagename|runs| 04:11:59 INFO - PID 12997 | |0;dojo.html;3333.30000699853;3364.5121457388686;3364.5457863188462;3372.8988130356097;3390.2541440882997;5874.118882167677;5880.823575292738;5898.469137777604;5914.290285165781;5934.287885453741;5889.440503152194;5920.733566989485;5970.820875373734;5985.760569577223;5988.790392336269;4982.103221420143;5221.634485586011;5237.895242095146;5261.86845328866;5290.523852853243;5280.9207861882105;5334.119870221409;5347.46525347466;5349.7592608332525;5371.677699338033;5187.610929180289;5248.317718696583;5283.28675628789;5297.682139071668;5304.124819404794;5232.7122008289525;5237.947620523784;5248.134057880445;5266.34170728659;5279.076161671731;5164;5193.402758682762;5193.844184674465;5203.297554830087;5208.322918020671;5769.596128271022;5813.447722466359;5851.356350801409;5871.3541510433815;5924.200232968537;6355.809325720235;6373.075903993941;6379.202599675041;6387.680615969183;6391.265004524493;6409;6415.935840641627;6422.261439934374;6425.485961123099;6438.484921206292;5837.328707198684;5891.49922256613;5911.379305172981;5950.285965684102;5956.940430595682;6555.967220163869;6562;6571.2771595124495;6596.505262105361;6610.405063544208;6185.752569897154;6249.6562689052535;6308.400701933309;6310.242770867525;6331.461825744771;6310.242770867433;6355.332690067568;6356.745730170834;6394.552381333262;6399.712012959428;6303.495720342362;6397.96801015992;6419.293877673452;6424.550281480345;6436.195475565554;6290.779822706275;6317.842053948688;6388.201474815648;6394.84012899672;6401.359864013654;4883.316335713003;4887.633427492881;4888.144574699484;4906.239532872411;4927.43334516528;4251.723637963522;4262.70161088727;4273.18809426208;4277.871663850089;4296.785160741951;5869.706514674334;5912.9113063304085;5951.077582974559;5957.880842383128;5987.760489580368;6396.488280937514;6403.199600049994;6404.519661025442;6423.935760642427;6433.324500927335;5867.178594996704;5925.585209035326;5925.911111333334;5937.614055086406;5960.910586341209;5358.035553600312;5371.167469042305;5404.648697834707;5412.161115027177;5444.700541470178;6634.535582509275;6650.667466626649;6675.7997260082275;6679.198496180489;6681.899771503528;6364.713587888464;6409.070684750592;6409.647469389229;6419.646919419477;6436.935630643634;6513.8697226056165;6616.139901812926;6641.435477984425;6655.434288085567;6662.900056499059;6216.751329946752;6228.22147231596;6261.78083767066;6286.4342209201395;6286.591371560834;6437.388448097423;6462.127612772216;6472.482201423969;6475.769603775268;6477.967610161919;6127.20346354971;6162.599431036968;6225.408586184486;6239.625622462667;6247.281562620356;6204.75904819029;6215.098810672517;6222.62664240147;6234.750609975732;6250.499960003098;6229.875402492015;6238.189035425366;6246.187995560548;6255.843603909939;6264.342244064308;6208.975519039489;6239.96880015597;6276.905846412399;6291.874162516816;6302.905456418066;6050.0017497112485;6108;6117.235345581802;6119.816405507842;6131.877362452815 04:11:59 INFO - PID 12997 | |1;ext.html;792.8850316704078;832.6710949175076;863.8013256950903;1166.5742004168476;1181.917265791394;38246.617533824654;39008.80495597522;39184.41223381652;39257.60742392575;39364.606353936455;40390.39414408786;40710.79644601773;40835.795821020925;40882.59117408825;40907.795461022724;7030.543014704053;7103.751368702096;7106.324899134574;7216.278372162794;7415.110186777594;7342.963285183567;7416.925830741678;7418.591977441239;7425.443091768112;7456.627168641547;7366.116066072079;7430.665620047083;7457.216992215821;7457.216992215821;7464.066991626047;7388.039554857888;7404.1855395906405;7419.962900185518;7421.035265415516;7457.403407727369;7289.453291003196;7296;7333.706651733924;7364.889526657104;7387.852242955165;38122.42816357757;38161.61838381609;38386;38481.80759096215;38485.23029539421;3450.3616830886367;3471.8437670304897;3489.5638045244345;3495.353359628477;3500.8249587520777;29807;30010.099697009126;30080.247993800112;30081.097567073022;30104.698953010407;3690.2435000824767;3702.426123950792;3736.6076561961145;3743.513343265358;3745.9063523412133;149423;155264;155333;201168;201833;42439.57560424356;42634;42659.36010959838;42739.35890961638;42750.57249427466;44262.55737442649;44403;44429.555704442544;44559;44582.55417445849;15170.848291517164;15284.770728439082;15334.539963801104;15341.309641066178;15380.07719536809;12352.320622365856;12466.81299780504;12472.937635311766;12477.500899964081;12493.375331233401;14466.566003019927;14618.63453413652;14628.926855365868;14637.634059148393;14811.11133331982;5794.391588883191;5838.328592211865;5917.378675239124;6003.579749417586;6064.787732429432;1018.8369860822232;1019.3934608907688;1044.9164066874632;1067.3595842494442;1077.3320541264309;25267.494650107263;25586;25635.74364256371;25886.352841178745;25972;1141.3222562832623;1145.6563031090639;1159.6636975277074;1190.9761804763857;1192.9403529823473;13121.934390327988;13477.797833032513;13632.727345453035;13691.726165476635;13782.862171378358;244353;244648;245879;246354;246369;51956.74021629868;52372;52793.472065279624;52975.47024529705;53089.20366194433;1460.2114857976785;1485.5691849363564;1491.5599898030107;1511.7581187010026;1515.8787297016213;23784.524309514058;24168.274951751475;24351;24807;25532.48935021326;38161;38192.80903595464;38209.4268585977;38263;38328.6167138325;197780;198408;199832;199869;200837;34339.65660343465;35547.82226088853;36303.636963631085;36310.09224769402;36454.635453645125;42656.14687706291;43079.569204307554;43836.780816095714;44092.77953610211;44391.55608444003;31599.84200078985;32807;32821.53838462173;33379.83310083434;34665.65334346725;32346.676533234368;32692.50961235631;32946.17634559155;33989.83005084959;34113.48829767605;37347.253054938206;37915.62084379121;38014.619853802214;38766.4185037219;38852.80573597114;30699;31369.529457057706;31642;32088.197795055312;32745;25027.87486062558;26368.124400383385;26530;26531.469370612092;26541.203763887115 04:11:59 INFO - PID 12997 | |2;jquery.html;500.44450659767665;505.4137200847018;506.8859506611013;523.9449857764937;527.8020742221667;20640.277590284324;21377;21414.35756927293;22032.33902982909;24216.878915605397;24575.877120614416;24962;25058.74941250587;25091.74908250917;25224.873875630597;5805.593608447411;5861.912071318912;5927.962606543859;5939.762409503614;5948.821535353946;5813;5897.970510147443;5937.851553711149;5944.583879128462;5946;5950.464458198761;5979.730912108944;6026.2165918430765;6030.939690603103;6036.547258955596;6007.249093863267;6022.2773267207995;6036.788712395067;6041.667708276043;6049.576529642927;5582.106862901916;5602.271704678406;5605.887882242373;5617.747201375948;5618.971905140489;26918;27669.584956225674;27910.16269511918;28180.718192818014;28183;2160.1359456217483;2195.5938151442033;2220.666899965002;2221.955560888773;2228.821694264455;18495.722564161548;18951.715724264148;19066.52333691655;19081.809181908142;19134;2253.6844841722173;2274.8976296066717;2276.1350686739097;2321.7446080931086;2327.057541695616;126698;129432.35283823521;136794;136959;138175;14046.367913443919;14063.226522541154;14378.137311761118;14611.342489587994;14685.55943321702;21606.78393216079;21907.67138492924;21951.121955121616;21951.231706890503;21960.23139190121;9289.767755806024;9407.623695052258;9554.952225238829;9572.138507534217;10341.793164136676;8721.956390218009;9056.411333263317;9135.406198597202;9211.861822072675;9316.114969078062;8768;8973;8985.281177505783;9043;9089.954550227207;2534.6071358939394;2540.517301712706;2554.272032470737;2648.3246772073385;2659.893604255808;1031.504877658728;1032.55084038442;1036.8185567525652;1060.2419270221828;1063.8776540697763;20490.692639610417;24659.876700616383;27359.45281094367;27381.04166354168;27453.72546274512;1064.4305296666246;1073.3988966178965;1076.5532304093713;1086.1365214654368;1101.867775866885;11334.773304533863;11803.291802491878;11839.348835814113;12043.939780301218;12229.938850305869;531297;534711;538675;553404;559775;120312.39843800725;120492.39753801351;120650;120696;121321.39339303247;1225.6935766058486;1244.8381710377773;1277.0996447504488;1281.4105511464645;1287.575100216926;21508.89245553762;22218.88890555537;22405.88797056004;22617.208397706658;23086.42283942915;55440.445595543526;55628;55703.721481392335;56937;58087.12869307048;69916.95124573034;75034;77265.61367193128;77449;77768.61115694385;16409.753853692444;17045.829541704425;17115.229814658618;17210;17503.824961750728;18485.53786155357;18634.81365186385;18644.16101275473;18688.34590789316;18734.437966861016;15792.447264345692;15796.526104216891;15863.206839658202;15912.363505459653;16077.035377877364;13174.736505270033;14138.575842724735;14164.716705666035;14170.787438188641;14276.57170284893;16259.26833292481;16330.836691632932;16366.099864507567;16377.099259540839;16381.508554743377;16004.19979001022;16826.242819072926;16870.325186992384;16949.474547290803;17051.829481705023;14320.355583998537;14986.47547335838;15081.924590376977;15086.321115549606;15106.697866042838 04:11:59 INFO - PID 12997 | |3;mootools.html;1390.1936876611562;1444.1153297629376;1448.7102579484106;1452.6077958951084;1465.5603319004304;12988.22070675759;13282.402291896864;13623.386947587358;13624.182549047051;13673.316334183275;13337.799933000988;13514.864851351484;13604.387802548885;13614.319284035784;13638;2576.9999999999955;2623.173700284414;2625.8818353174056;2626.067745950189;2626.1727555819953;2541.5552278351306;2657.242685834528;2659;2659.7739192168688;2660.3349162709324;2557.9104731334405;2564.0897481394118;2585.4441295121546;2587.611858221263;2595.377109493727;2562.859042752648;2579.780718638899;2591.106068406397;2599;2599.896004159831;2460.052879641333;2468.9506209875703;2497.837640553358;2515.0442831723826;2524.4193835417773;12945.676358091028;13078.673033174151;13133.212007279593;13146.21122732639;13269.469221231138;7266.491345605809;7556.886646700304;7558.848823023509;7571.3942884569105;7590.3927685785;4411.735295882258;4491.708038977488;4543.954560454386;4548.5906268436;4551.112533056055;1492.3657445585582;1494.0662086196128;1526.7251894658957;1547.5280039587922;1603.7594360845849;20932.790672093237;21141.68287475689;21275.36173914785;21554.784452155436;22230.777692223033;6430.292667806538;6442.162518872517;6468.126802881551;6608.636524991076;6674.799756007327;15399.769003464957;15438.305276262596;15473.303701333241;15500.30248638814;15515.767263491056;7237.493375463772;7340;7452.776416707507;7459.179490256068;7479.326860582573;6816.420604248694;6887.862242755117;6893.724251030003;6904.3095690430555;6910.44716422685;4795.328653988445;4888.608911287089;4917.704937703749;4956.801727930842;4968.701877887338;1415.1367665723901;1426.9500567480295;1429.978550321746;1435.253668092586;1450.8404075551891;861.1259571534897;880.4365206267994;883.5317281840635;904.4076130134772;912.9041450647586;6807.353301436356;6847.554908930903;7068.893966590505;7172.354488096096;7198.352148306572;708.9397401220954;739.7780665800238;739.9223081576357;742.9591372474458;743.0785825576246;4285.207236661227;4384.057427653006;4517.548245175456;5003.099442100384;5005.896344266578;17276.568085797706;18122.546936326435;18701.34545290908;18758.624827503372;18764.624707505773;18102.90948545249;18413;18448.26206951707;18452.538686532676;18580.25678972826;10324.845127323097;10342.689719308433;10694.786104277871;10766.94616526928;10830.566777328977;7426.628668566442;7626.504277221963;7905.881411778943;8150.75547733569;8188.0993090758775;16224.26990785441;16286.67426651484;16312.592185195464;16771.32914683399;16874.578135546217;16295.755563666791;16650.916745416194;16819;16918.407855724992;16928.068956207528;10816.459177041274;10916.836247456453;10978.737445193905;10988.505517251582;11007.724806879893;12201.389930503618;12313.753724925631;12415.379231038592;12419.44112514921;12435.440405181607;10209.489525523843;10518.263721539419;10525.684229473129;10776.29954052984;10952.452377381258;10021.699349019542;10098.293119481566;10152.949235253776;10290.742731431774;10297.227707921786;9055.547222638974;9162.175404213385;9231.630734770533;9359.251259899056;9373.20327772147;6473.320301368289;6624.503162262753;6747.460203183831;6917.515773895779;7114.928850711427;6692.5315227935525;6717.395434410731;6746.156730408699;6899.862002759816;7030.683619237249 04:11:59 INFO - PID 12997 | |4;prototype.html;422.23786066150586;448.68816172759927;452.93658887755697;455.382956094492;457.7665390650767;6365.395287447696;6387.520935929806;6392.488600911927;6403.903941440871;6409.583377080487;5945.346011938684;6210.31686514483;6218.347073557279;6228.283747369054;6228.346023667517;4790.616750659948;4793.640476964224;4805.111054454919;4807.5432833880905;4808.879778005543;4816.157172494817;4817.566419022287;4820.373351464323;4829.565339119478;4834.734089625069;4796.808127674906;4804.111239420701;4821.108095002436;4824.348712923746;4829.830955916544;4822.421309442854;4835.540623640749;4838.322634831126;4838.879028024292;4839.516048395168;4288.721233119837;4294.463192100988;4310.935335969963;4313.870583882489;4316.891837876755;6092.573519853612;6133.325334213233;6159.661218632973;6179.28938172107;6196.907046394308;5718.857028574277;5736.770529178828;5744.8851022979725;5750.396208398141;5760.164776107441;6603.3396660334065;6666.833329166761;6694.933050669529;6704.698288577026;6736.663166841688;4789.640776941708;4806.279058141272;4811.518848115161;4818.132736107499;4819.903601927942;6588.637624930627;6932.341427564374;6943.1321084863885;6954.617496037716;6999.615021173833;4891;4902.142125128088;4913.65604407688;4927.655064145547;4933.605311575066;4953.281774142729;4963.461326988645;4967.602591792648;4969.726665033458;4994.355249617817;5541.667499950016;5649.971750141223;5654.180143879114;5668.121441176624;5668.744906479218;6658.400743933069;6661.26726060133;6680.265170831205;6686.7993960181275;6694.330566943267;1705.7867766529184;1716.5022143578221;1723.4657256250603;1727.4385824607052;1733.7832770903638;1144.582227486978;1183.923045002072;1190.4464424042687;1191.5710344276054;1201.9218750781172;6264.843378915563;6270.247570291503;6274.560780745304;6274.717637706314;6297.4647154992335;6793.762218322335;6816.216135144522;6821.192384018239;6823.55646882951;6828.2488926218075;6209.534284928648;6213.471854892295;6261.186045814015;6270;6271.3728627136925;3618.222082252328;3624.444766439654;3630.618785027587;3639.8180090995343;3654.8172591370326;7062.329078737512;7077.267413395167;7098.645067746592;7108.289171082851;7108.68010939509;6918.5502942308585;6943.6875340609795;6990.755323563651;6991.8601627967155;6999.825004374931;7035.100522858799;7058.505904586629;7077.716891324392;7088.326608972139;7107.218205997337;6765.25582185969;6806.455483561403;6814.863702725818;6876.965615172092;6884.345987131214;6371.87256254863;6764.492663050192;6773.593584384953;6776.491763117688;6802;7016.649167541705;7065.869460886233;7077.5399599025895;7094.716211351488;7110.85778284421;4873.390826146731;4911.778969946289;4915.827946021872;4923.163062279493;4940.901181976412;6709;6798.694058767466;6823.147106611674;6905.827354316182;6920.307969203241;6666.300038496082;6672.232693240339;6683.699233534406;6689.331066893272;6706.362895524917;6656.866862662817;6660.83347916306;6683.732650693918;6693.330666933268;6711.899321510279;6670.9332906670315;6680.498962577729;6686.866262674622;6687.264400915993;6696;6664.166979127609;6692.765753198614;6726.192856857208;6726.831829204309;6731.394174524316;6528.869422611616;6574.474042076718;6600.867982640416;6605.943049112119;6606.141201643948 04:11:59 INFO - PID 12997 | |5;yui.html;815.991840081599;833.720703564306;845.1590667286049;845.8562044452442;856.0284077571956;17256.13719314034;17483.475495735132;17538.21078051489;19637.607247855034;20749.688754668656;18857.43427697168;18927.053647317647;19118.13968371423;19134.330298439556;19151.712724309113;967.6274634265806;993.4933184076101;993.8509223616479;998.4658207858797;998.6454808542971;968.8837339519232;996.1482932093065;1002.2483137646765;1008.4100801031369;1008.9848652270222;1026;1026.3892983674702;1029.1149611334247;1029.5881647341048;1035.2339268940966;1015.5937624950005;1018.5263852308713;1020.1532727835915;1020.6274709730932;1021.2953062387004;755.8186035351531;758.4614923404334;759.6050053971903;761.2235519769804;765.6095391350395;16683.66632667352;16774.412895548598;16859.831401685948;16880.409185678443;16963.151842407955;18309;18395.35616253438;18709.62580748391;18798.624027519374;18829.529261768428;14721.484748033767;14838.851611483855;14856.702865942729;14972.47596334134;15029.624259393493;3403.149212696826;3435.347284016029;3464.082018265162;3474.0793689672255;3510.350585141757;95825.5208723959;98207;101794.49102754438;103167.48416257945;103634.48182759114;14040.85959140416;14507.057041292283;14744.115353078849;15067.773983390258;15085.3211605478;27300.180994570193;27635.585466218025;27770.861145694143;27854.860725696646;27866.72133278682;8153.6738530458115;8356.247937685637;8366.330693544502;8405.41162118658;8514.446560973516;3815.1606646537716;3911.902202444962;3912.5109361329833;3917.373220284741;3934.5475270344277;4527.411436513298;4599.310103484504;4611.423572053493;4618.122556714214;4627.699199552018;920.8112336970905;922.257582645963;929.1823195587839;933.0622724162309;934.4113208678625;690.5649440852231;719.9964000180071;720.7657511308846;729.4055344894001;739.2164305835831;11877.762444751057;12760.425780839885;12785.61643150707;12851.807222891664;13548.187108773505;710.1691021504852;721.3832173491589;732.772840419461;734.13738856843;736.1019556141499;5645.181448689917;5839.445252700986;6013.398660133952;6147.96926015376;6243.7814676486105;111864;112685.74628507384;113913.43043284897;114607;117788;101069.15388944065;104099;105090.47454762677;106150;110592.4470377643;84720.45838624852;85816.99999999875;86312.56843715742;86537.56731216429;88174.1182588166;11333.4492782432;11369.715757106138;11513.654590362303;11548.133889958455;11585.536578536765;42541;43047.56952430436;43094;43185.56814431815;43893.341599876665;55141.72429137828;56967.43032569787;57133.42866571281;57698;58329.4167058341;16303.26635301438;16351.591210219363;16555.337786488406;16612.83387166113;16753.91623041877;17902.194401252236;18070.277188912296;18123.45629631113;19825.702614461083;21145.471363216042;19469.902650487224;19673.508162296057;19870.701939471208;20002.499937501678;20393.796062039783;18970.810291896905;19373;19582.412527624194;19728.802711972698;19965.20139194416;18762.343317983807;18873.90563047176;18905.71641425407;19110.617787643892;19226.230950762372;11989.700257493632;12131.393430328624;12189.390530473618;12489.000879929765;12920.935395323339;12920.353982301036;13230.801537976746;13554.72890542164;13606.319684015958;13608.183508989492 04:11:59 INFO - PID 12997 | __end_tp_report 04:11:59 INFO - PID 12997 | __start_cc_report 04:11:59 INFO - PID 12997 | _x_x_mozilla_cycle_collect,325 04:11:59 INFO - PID 12997 | __end_cc_report 04:11:59 INFO - PID 12997 | __startTimestamp1496920319819__endTimestamp 04:11:59 INFO - PID 12997 | 04:11:59 INFO - PID 12997 | ------- Summary: start ------- 04:11:59 INFO - PID 12997 | Number of tests: 6 04:11:59 INFO - PID 12997 | 04:11:59 INFO - PID 12997 | [#0] dojo.html Cycles:165 Average:5887.46 Median:6185.75 stddev:716.59 (11.6%) stddev-sans-first:690.20 04:11:59 INFO - PID 12997 | Values: 3333.3 3364.5 3364.5 3372.9 3390.3 5874.1 5880.8 5898.5 5914.3 5934.3 5889.4 5920.7 5970.8 5985.8 5988.8 4982.1 5221.6 5237.9 5261.9 5290.5 5280.9 5334.1 5347.5 5349.8 5371.7 5187.6 5248.3 5283.3 5297.7 5304.1 5232.7 5237.9 5248.1 5266.3 5279.1 5164.0 5193.4 5193.8 5203.3 5208.3 5769.6 5813.4 5851.4 5871.4 5924.2 6355.8 6373.1 6379.2 6387.7 6391.3 6409.0 6415.9 6422.3 6425.5 6438.5 5837.3 5891.5 5911.4 5950.3 5956.9 6556.0 6562.0 6571.3 6596.5 6610.4 6185.8 6249.7 6308.4 6310.2 6331.5 6310.2 6355.3 6356.7 6394.6 6399.7 6303.5 6398.0 6419.3 6424.6 6436.2 6290.8 6317.8 6388.2 6394.8 6401.4 4883.3 4887.6 4888.1 4906.2 4927.4 4251.7 4262.7 4273.2 4277.9 4296.8 5869.7 5912.9 5951.1 5957.9 5987.8 6396.5 6403.2 6404.5 6423.9 6433.3 5867.2 5925.6 5925.9 5937.6 5960.9 5358.0 5371.2 5404.6 5412.2 5444.7 6634.5 6650.7 6675.8 6679.2 6681.9 6364.7 6409.1 6409.6 6419.6 6436.9 6513.9 6616.1 6641.4 6655.4 6662.9 6216.8 6228.2 6261.8 6286.4 6286.6 6437.4 6462.1 6472.5 6475.8 6478.0 6127.2 6162.6 6225.4 6239.6 6247.3 6204.8 6215.1 6222.6 6234.8 6250.5 6229.9 6238.2 6246.2 6255.8 6264.3 6209.0 6240.0 6276.9 6291.9 6302.9 6050.0 6108.0 6117.2 6119.8 6131.9 04:11:59 INFO - PID 12997 | 04:11:59 INFO - PID 12997 | [#1] ext.html Cycles:180 Average:37388.82 Median:3492.46 stddev:54039.44 (1547.3%) stddev-sans-first:54121.17 04:11:59 INFO - PID 12997 | Values: 792.9 832.7 863.8 1166.6 1181.9 38246.6 39008.8 39184.4 39257.6 39364.6 40390.4 40710.8 40835.8 40882.6 40907.8 7030.5 7103.8 7106.3 7216.3 7415.1 7343.0 7416.9 7418.6 7425.4 7456.6 7366.1 7430.7 7457.2 7457.2 7464.1 7388.0 7404.2 7420.0 7421.0 7457.4 7289.5 7296.0 7333.7 7364.9 7387.9 38122.4 38161.6 38386.0 38481.8 38485.2 3450.4 3471.8 3489.6 3495.4 3500.8 29807.0 30010.1 30080.2 30081.1 30104.7 3690.2 3702.4 3736.6 3743.5 3745.9 149423.0 155264.0 155333.0 201168.0 201833.0 42439.6 42634.0 42659.4 42739.4 42750.6 44262.6 44403.0 44429.6 44559.0 44582.6 15170.8 15284.8 15334.5 15341.3 15380.1 12352.3 12466.8 12472.9 12477.5 12493.4 14466.6 14618.6 14628.9 14637.6 14811.1 5794.4 5838.3 5917.4 6003.6 6064.8 1018.8 1019.4 1044.9 1067.4 1077.3 25267.5 25586.0 25635.7 25886.4 25972.0 1141.3 1145.7 1159.7 1191.0 1192.9 13121.9 13477.8 13632.7 13691.7 13782.9 244353.0 244648.0 245879.0 246354.0 246369.0 51956.7 52372.0 52793.5 52975.5 53089.2 1460.2 1485.6 1491.6 1511.8 1515.9 23784.5 24168.3 24351.0 24807.0 25532.5 38161.0 38192.8 38209.4 38263.0 38328.6 197780.0 198408.0 199832.0 199869.0 200837.0 34339.7 35547.8 36303.6 36310.1 36454.6 42656.1 43079.6 43836.8 44092.8 44391.6 31599.8 32807.0 32821.5 33379.8 34665.7 32346.7 32692.5 32946.2 33989.8 34113.5 37347.3 37915.6 38014.6 38766.4 38852.8 30699.0 31369.5 31642.0 32088.2 32745.0 25027.9 26368.1 26530.0 26531.5 26541.2 04:11:59 INFO - PID 12997 | 04:11:59 INFO - PID 12997 | [#2] jquery.html Cycles:180 Average:36138.15 Median:12220.42 stddev:90995.47 (744.6%) stddev-sans-first:91211.40 04:11:59 INFO - PID 12997 | Values: 500.4 505.4 506.9 523.9 527.8 20640.3 21377.0 21414.4 22032.3 24216.9 24575.9 24962.0 25058.7 25091.7 25224.9 5805.6 5861.9 5928.0 5939.8 5948.8 5813.0 5898.0 5937.9 5944.6 5946.0 5950.5 5979.7 6026.2 6030.9 6036.5 6007.2 6022.3 6036.8 6041.7 6049.6 5582.1 5602.3 5605.9 5617.7 5619.0 26918.0 27669.6 27910.2 28180.7 28183.0 2160.1 2195.6 2220.7 2222.0 2228.8 18495.7 18951.7 19066.5 19081.8 19134.0 2253.7 2274.9 2276.1 2321.7 2327.1 126698.0 129432.4 136794.0 136959.0 138175.0 14046.4 14063.2 14378.1 14611.3 14685.6 21606.8 21907.7 21951.1 21951.2 21960.2 9289.8 9407.6 9555.0 9572.1 10341.8 8722.0 9056.4 9135.4 9211.9 9316.1 8768.0 8973.0 8985.3 9043.0 9090.0 2534.6 2540.5 2554.3 2648.3 2659.9 1031.5 1032.6 1036.8 1060.2 1063.9 20490.7 24659.9 27359.5 27381.0 27453.7 1064.4 1073.4 1076.6 1086.1 1101.9 11334.8 11803.3 11839.3 12043.9 12229.9 531297.0 534711.0 538675.0 553404.0 559775.0 120312.4 120492.4 120650.0 120696.0 121321.4 1225.7 1244.8 1277.1 1281.4 1287.6 21508.9 22218.9 22405.9 22617.2 23086.4 55440.4 55628.0 55703.7 56937.0 58087.1 69917.0 75034.0 77265.6 77449.0 77768.6 16409.8 17045.8 17115.2 17210.0 17503.8 18485.5 18634.8 18644.2 18688.3 18734.4 15792.4 15796.5 15863.2 15912.4 16077.0 13174.7 14138.6 14164.7 14170.8 14276.6 16259.3 16330.8 16366.1 16377.1 16381.5 16004.2 16826.2 16870.3 16949.5 17051.8 14320.4 14986.5 15081.9 15086.3 15106.7 04:11:59 INFO - PID 12997 | 04:11:59 INFO - PID 12997 | [#3] mootools.html Cycles:180 Average:8349.89 Median:2549.73 stddev:5664.63 (222.2%) stddev-sans-first:5656.38 04:11:59 INFO - PID 12997 | Values: 1390.2 1444.1 1448.7 1452.6 1465.6 12988.2 13282.4 13623.4 13624.2 13673.3 13337.8 13514.9 13604.4 13614.3 13638.0 2577.0 2623.2 2625.9 2626.1 2626.2 2541.6 2657.2 2659.0 2659.8 2660.3 2557.9 2564.1 2585.4 2587.6 2595.4 2562.9 2579.8 2591.1 2599.0 2599.9 2460.1 2469.0 2497.8 2515.0 2524.4 12945.7 13078.7 13133.2 13146.2 13269.5 7266.5 7556.9 7558.8 7571.4 7590.4 4411.7 4491.7 4544.0 4548.6 4551.1 1492.4 1494.1 1526.7 1547.5 1603.8 20932.8 21141.7 21275.4 21554.8 22230.8 6430.3 6442.2 6468.1 6608.6 6674.8 15399.8 15438.3 15473.3 15500.3 15515.8 7237.5 7340.0 7452.8 7459.2 7479.3 6816.4 6887.9 6893.7 6904.3 6910.4 4795.3 4888.6 4917.7 4956.8 4968.7 1415.1 1427.0 1430.0 1435.3 1450.8 861.1 880.4 883.5 904.4 912.9 6807.4 6847.6 7068.9 7172.4 7198.4 708.9 739.8 739.9 743.0 743.1 4285.2 4384.1 4517.5 5003.1 5005.9 17276.6 18122.5 18701.3 18758.6 18764.6 18102.9 18413.0 18448.3 18452.5 18580.3 10324.8 10342.7 10694.8 10766.9 10830.6 7426.6 7626.5 7905.9 8150.8 8188.1 16224.3 16286.7 16312.6 16771.3 16874.6 16295.8 16650.9 16819.0 16918.4 16928.1 10816.5 10916.8 10978.7 10988.5 11007.7 12201.4 12313.8 12415.4 12419.4 12435.4 10209.5 10518.3 10525.7 10776.3 10952.5 10021.7 10098.3 10152.9 10290.7 10297.2 9055.5 9162.2 9231.6 9359.3 9373.2 6473.3 6624.5 6747.5 6917.5 7114.9 6692.5 6717.4 6746.2 6899.9 7030.7 04:11:59 INFO - PID 12997 | 04:11:59 INFO - PID 12997 | [#4] prototype.html Cycles:180 Average:5604.01 Median:6270.81 stddev:1647.17 (26.3%) stddev-sans-first:1605.21 04:11:59 INFO - PID 12997 | Values: 422.2 448.7 452.9 455.4 457.8 6365.4 6387.5 6392.5 6403.9 6409.6 5945.3 6210.3 6218.3 6228.3 6228.3 4790.6 4793.6 4805.1 4807.5 4808.9 4816.2 4817.6 4820.4 4829.6 4834.7 4796.8 4804.1 4821.1 4824.3 4829.8 4822.4 4835.5 4838.3 4838.9 4839.5 4288.7 4294.5 4310.9 4313.9 4316.9 6092.6 6133.3 6159.7 6179.3 6196.9 5718.9 5736.8 5744.9 5750.4 5760.2 6603.3 6666.8 6694.9 6704.7 6736.7 4789.6 4806.3 4811.5 4818.1 4819.9 6588.6 6932.3 6943.1 6954.6 6999.6 4891.0 4902.1 4913.7 4927.7 4933.6 4953.3 4963.5 4967.6 4969.7 4994.4 5541.7 5650.0 5654.2 5668.1 5668.7 6658.4 6661.3 6680.3 6686.8 6694.3 1705.8 1716.5 1723.5 1727.4 1733.8 1144.6 1183.9 1190.4 1191.6 1201.9 6264.8 6270.2 6274.6 6274.7 6297.5 6793.8 6816.2 6821.2 6823.6 6828.2 6209.5 6213.5 6261.2 6270.0 6271.4 3618.2 3624.4 3630.6 3639.8 3654.8 7062.3 7077.3 7098.6 7108.3 7108.7 6918.6 6943.7 6990.8 6991.9 6999.8 7035.1 7058.5 7077.7 7088.3 7107.2 6765.3 6806.5 6814.9 6877.0 6884.3 6371.9 6764.5 6773.6 6776.5 6802.0 7016.6 7065.9 7077.5 7094.7 7110.9 4873.4 4911.8 4915.8 4923.2 4940.9 6709.0 6798.7 6823.1 6905.8 6920.3 6666.3 6672.2 6683.7 6689.3 6706.4 6656.9 6660.8 6683.7 6693.3 6711.9 6670.9 6680.5 6686.9 6687.3 6696.0 6664.2 6692.8 6726.2 6726.8 6731.4 6528.9 6574.5 6600.9 6605.9 6606.1 04:11:59 INFO - PID 12997 | 04:11:59 INFO - PID 12997 | [#5] yui.html Cycles:180 Average:22640.55 Median:19610.01 stddev:30585.99 (156.0%) stddev-sans-first:30627.89 04:11:59 INFO - PID 12997 | Values: 816.0 833.7 845.2 845.9 856.0 17256.1 17483.5 17538.2 19637.6 20749.7 18857.4 18927.1 19118.1 19134.3 19151.7 967.6 993.5 993.9 998.5 998.6 968.9 996.1 1002.2 1008.4 1009.0 1026.0 1026.4 1029.1 1029.6 1035.2 1015.6 1018.5 1020.2 1020.6 1021.3 755.8 758.5 759.6 761.2 765.6 16683.7 16774.4 16859.8 16880.4 16963.2 18309.0 18395.4 18709.6 18798.6 18829.5 14721.5 14838.9 14856.7 14972.5 15029.6 3403.1 3435.3 3464.1 3474.1 3510.4 95825.5 98207.0 101794.5 103167.5 103634.5 14040.9 14507.1 14744.1 15067.8 15085.3 27300.2 27635.6 27770.9 27854.9 27866.7 8153.7 8356.2 8366.3 8405.4 8514.4 3815.2 3911.9 3912.5 3917.4 3934.5 4527.4 4599.3 4611.4 4618.1 4627.7 920.8 922.3 929.2 933.1 934.4 690.6 720.0 720.8 729.4 739.2 11877.8 12760.4 12785.6 12851.8 13548.2 710.2 721.4 732.8 734.1 736.1 5645.2 5839.4 6013.4 6148.0 6243.8 111864.0 112685.7 113913.4 114607.0 117788.0 101069.2 104099.0 105090.5 106150.0 110592.4 84720.5 85817.0 86312.6 86537.6 88174.1 11333.4 11369.7 11513.7 11548.1 11585.5 42541.0 43047.6 43094.0 43185.6 43893.3 55141.7 56967.4 57133.4 57698.0 58329.4 16303.3 16351.6 16555.3 16612.8 16753.9 17902.2 18070.3 18123.5 19825.7 21145.5 19469.9 19673.5 19870.7 20002.5 20393.8 18970.8 19373.0 19582.4 19728.8 19965.2 18762.3 18873.9 18905.7 19110.6 19226.2 11989.7 12131.4 12189.4 12489.0 12920.9 12920.4 13230.8 13554.7 13606.3 13608.2 04:11:59 INFO - PID 12997 | -------- Summary: end -------- 04:11:59 INFO - PID 12997 | 04:12:00 INFO - TEST-INFO | 12997: exit 0 04:12:00 INFO - TEST-OK | dromaeo_css | took 1139844ms 04:12:00 INFO - TEST-START | kraken 04:12:00 INFO - operating with platform_type : linux_ 04:12:00 INFO - Initialising browser for kraken test... 04:12:00 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:59012/getInfo.html -profile /tmp/tmpGXSOX2/profile 04:12:00 INFO - TEST-INFO | started process 13408 (/builds/slave/test/build/application/firefox/firefox http://localhost:59012/getInfo.html) 04:12:34 INFO - TEST-INFO | 13408: killed by SIGTERM 04:12:34 INFO - Browser initialized. 04:12:34 INFO - Running cycle 1/1 for kraken test... 04:12:34 INFO - TEST-INFO | started process 13613 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGXSOX2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:12:46 INFO - PID 13613 | RSS: Main: 177917952 04:12:46 INFO - PID 13613 | 04:12:49 INFO - PID 13613 | Cycle 1(1): loaded http://localhost:59012/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59012/tests/kraken/driver.html?testName=audio-beat-detection) 04:12:49 INFO - PID 13613 | RSS: Main: 182980608 04:12:49 INFO - PID 13613 | 04:12:52 INFO - PID 13613 | Cycle 1(1): loaded http://localhost:59012/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59012/tests/kraken/driver.html?testName=audio-dft) 04:12:53 INFO - PID 13613 | RSS: Main: 182030336 04:12:53 INFO - PID 13613 | 04:12:56 INFO - PID 13613 | Cycle 1(1): loaded http://localhost:59012/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59012/tests/kraken/driver.html?testName=audio-fft) 04:12:56 INFO - PID 13613 | RSS: Main: 177467392 04:12:56 INFO - PID 13613 | 04:12:58 INFO - PID 13613 | Cycle 1(1): loaded http://localhost:59012/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59012/tests/kraken/driver.html?testName=audio-oscillator) 04:12:59 INFO - PID 13613 | RSS: Main: 178462720 04:12:59 INFO - PID 13613 | 04:13:01 INFO - PID 13613 | Cycle 1(1): loaded http://localhost:59012/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59012/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:13:02 INFO - PID 13613 | RSS: Main: 178573312 04:13:02 INFO - PID 13613 | 04:13:05 INFO - PID 13613 | Cycle 1(1): loaded http://localhost:59012/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59012/tests/kraken/driver.html?testName=imaging-darkroom) 04:13:05 INFO - PID 13613 | RSS: Main: 179548160 04:13:05 INFO - PID 13613 | 04:13:09 INFO - PID 13613 | Cycle 1(1): loaded http://localhost:59012/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59012/tests/kraken/driver.html?testName=imaging-desaturate) 04:13:09 INFO - PID 13613 | RSS: Main: 178892800 04:13:09 INFO - PID 13613 | 04:13:12 INFO - PID 13613 | Cycle 1(1): loaded http://localhost:59012/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59012/tests/kraken/driver.html?testName=json-parse-financial) 04:13:13 INFO - PID 13613 | RSS: Main: 179679232 04:13:13 INFO - PID 13613 | 04:13:14 INFO - PID 13613 | Cycle 1(1): loaded http://localhost:59012/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59012/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:13:15 INFO - PID 13613 | RSS: Main: 179585024 04:13:15 INFO - PID 13613 | 04:13:17 INFO - PID 13613 | Cycle 1(1): loaded http://localhost:59012/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59012/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:13:17 INFO - PID 13613 | RSS: Main: 179417088 04:13:17 INFO - PID 13613 | 04:13:19 INFO - PID 13613 | Cycle 1(1): loaded http://localhost:59012/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59012/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:13:20 INFO - PID 13613 | RSS: Main: 179642368 04:13:20 INFO - PID 13613 | 04:13:23 INFO - PID 13613 | Cycle 1(1): loaded http://localhost:59012/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59012/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:13:23 INFO - PID 13613 | RSS: Main: 179425280 04:13:23 INFO - PID 13613 | 04:13:26 INFO - PID 13613 | Cycle 1(1): loaded http://localhost:59012/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59012/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:13:27 INFO - PID 13613 | RSS: Main: 179421184 04:13:27 INFO - PID 13613 | 04:13:28 INFO - PID 13613 | Cycle 1(1): loaded http://localhost:59012/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59012/tests/kraken/driver.html?testName=ai-astar) 04:13:29 INFO - PID 13613 | RSS: Main: 181223424 04:13:29 INFO - PID 13613 | 04:13:29 INFO - PID 13613 | __start_tp_report 04:13:29 INFO - PID 13613 | _x_x_mozilla_page_load 04:13:29 INFO - PID 13613 | _x_x_mozilla_page_load_details 04:13:29 INFO - PID 13613 | |i|pagename|runs| 04:13:29 INFO - PID 13613 | |0;ai-astar;99;110;103;107;108;109;108;100;108;109 04:13:29 INFO - PID 13613 | |1;audio-beat-detection;145;117;149;184;116;154;145;117;164;118 04:13:29 INFO - PID 13613 | |2;audio-dft;163;164;161;162;163;165;165;164;177;169 04:13:29 INFO - PID 13613 | |3;audio-fft;73;72;76;175;74;73;75;72;165;73 04:13:29 INFO - PID 13613 | |4;audio-oscillator;81;81;138;82;81;81;132;83;82;131 04:13:29 INFO - PID 13613 | |5;imaging-gaussian-blur;113;115;114;114;114;114;116;117;114;114 04:13:29 INFO - PID 13613 | |6;imaging-darkroom;148;150;149;148;148;152;151;148;148;147 04:13:29 INFO - PID 13613 | |7;imaging-desaturate;94;95;99;94;94;94;94;94;95;94 04:13:29 INFO - PID 13613 | |8;json-parse-financial;54;49;53;49;49;52;49;49;48;49 04:13:29 INFO - PID 13613 | |9;json-stringify-tinderbox;55;58;55;56;54;56;58;55;55;55 04:13:29 INFO - PID 13613 | |10;stanford-crypto-aes;81;80;79;80;81;79;79;80;99;81 04:13:29 INFO - PID 13613 | |11;stanford-crypto-ccm;125;127;139;123;126;121;127;127;121;124 04:13:29 INFO - PID 13613 | |12;stanford-crypto-pbkdf2;197;175;177;174;172;170;174;182;174;183 04:13:29 INFO - PID 13613 | |13;stanford-crypto-sha256-iterative;63;66;65;66;63;65;62;62;65;62 04:13:29 INFO - PID 13613 | __end_tp_report 04:13:29 INFO - PID 13613 | __start_cc_report 04:13:29 INFO - PID 13613 | _x_x_mozilla_cycle_collect,868 04:13:29 INFO - PID 13613 | __end_cc_report 04:13:29 INFO - PID 13613 | __startTimestamp1496920409177__endTimestamp 04:13:29 INFO - PID 13613 | 04:13:29 INFO - PID 13613 | ------- Summary: start ------- 04:13:29 INFO - PID 13613 | Number of tests: 14 04:13:29 INFO - PID 13613 | 04:13:29 INFO - PID 13613 | [#0] ai-astar Cycles:10 Average:106.10 Median:108.50 stddev:3.96 (3.6%) stddev-sans-first:3.26 04:13:29 INFO - PID 13613 | Values: 99.0 110.0 103.0 107.0 108.0 109.0 108.0 100.0 108.0 109.0 04:13:29 INFO - PID 13613 | 04:13:29 INFO - PID 13613 | [#1] audio-beat-detection Cycles:10 Average:140.90 Median:147.00 stddev:23.45 (16.0%) stddev-sans-first:24.82 04:13:29 INFO - PID 13613 | Values: 145.0 117.0 149.0 184.0 116.0 154.0 145.0 117.0 164.0 118.0 04:13:29 INFO - PID 13613 | 04:13:29 INFO - PID 13613 | [#2] audio-dft Cycles:10 Average:165.30 Median:164.50 stddev:4.64 (2.8%) stddev-sans-first:4.85 04:13:29 INFO - PID 13613 | Values: 163.0 164.0 161.0 162.0 163.0 165.0 165.0 164.0 177.0 169.0 04:13:29 INFO - PID 13613 | 04:13:29 INFO - PID 13613 | [#3] audio-fft Cycles:10 Average:92.80 Median:73.00 stddev:40.78 (55.9%) stddev-sans-first:42.61 04:13:29 INFO - PID 13613 | Values: 73.0 72.0 76.0 175.0 74.0 73.0 75.0 72.0 165.0 73.0 04:13:29 INFO - PID 13613 | 04:13:29 INFO - PID 13613 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:81.00 stddev:25.24 (31.2%) stddev-sans-first:26.08 04:13:29 INFO - PID 13613 | Values: 81.0 81.0 138.0 82.0 81.0 81.0 132.0 83.0 82.0 131.0 04:13:29 INFO - PID 13613 | 04:13:29 INFO - PID 13613 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.00 stddev:1.18 (1.0%) stddev-sans-first:1.12 04:13:29 INFO - PID 13613 | Values: 113.0 115.0 114.0 114.0 114.0 114.0 116.0 117.0 114.0 114.0 04:13:29 INFO - PID 13613 | 04:13:29 INFO - PID 13613 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:148.50 stddev:1.60 (1.1%) stddev-sans-first:1.66 04:13:29 INFO - PID 13613 | Values: 148.0 150.0 149.0 148.0 148.0 152.0 151.0 148.0 148.0 147.0 04:13:29 INFO - PID 13613 | 04:13:29 INFO - PID 13613 | [#7] imaging-desaturate Cycles:10 Average:94.70 Median:94.00 stddev:1.57 (1.7%) stddev-sans-first:1.64 04:13:29 INFO - PID 13613 | Values: 94.0 95.0 99.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 04:13:29 INFO - PID 13613 | 04:13:29 INFO - PID 13613 | [#8] json-parse-financial Cycles:10 Average:50.10 Median:49.00 stddev:2.08 (4.2%) stddev-sans-first:1.66 04:13:29 INFO - PID 13613 | Values: 54.0 49.0 53.0 49.0 49.0 52.0 49.0 49.0 48.0 49.0 04:13:29 INFO - PID 13613 | 04:13:29 INFO - PID 13613 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:55.50 stddev:1.34 (2.4%) stddev-sans-first:1.39 04:13:29 INFO - PID 13613 | Values: 55.0 58.0 55.0 56.0 54.0 56.0 58.0 55.0 55.0 55.0 04:13:29 INFO - PID 13613 | 04:13:29 INFO - PID 13613 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:80.50 stddev:6.06 (7.5%) stddev-sans-first:6.42 04:13:29 INFO - PID 13613 | Values: 81.0 80.0 79.0 80.0 81.0 79.0 79.0 80.0 99.0 81.0 04:13:29 INFO - PID 13613 | 04:13:29 INFO - PID 13613 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:126.50 stddev:5.12 (4.0%) stddev-sans-first:5.42 04:13:29 INFO - PID 13613 | Values: 125.0 127.0 139.0 123.0 126.0 121.0 127.0 127.0 121.0 124.0 04:13:29 INFO - PID 13613 | 04:13:29 INFO - PID 13613 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.80 Median:176.00 stddev:7.89 (4.5%) stddev-sans-first:4.33 04:13:29 INFO - PID 13613 | Values: 197.0 175.0 177.0 174.0 172.0 170.0 174.0 182.0 174.0 183.0 04:13:29 INFO - PID 13613 | 04:13:29 INFO - PID 13613 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:65.00 stddev:1.66 (2.6%) stddev-sans-first:1.73 04:13:29 INFO - PID 13613 | Values: 63.0 66.0 65.0 66.0 63.0 65.0 62.0 62.0 65.0 62.0 04:13:29 INFO - PID 13613 | -------- Summary: end -------- 04:13:29 INFO - PID 13613 | 04:13:30 INFO - TEST-INFO | 13613: exit 0 04:13:30 INFO - TEST-OK | kraken | took 89851ms 04:13:30 INFO - SUITE-END | took 1229s 04:13:30 INFO - Completed test suite (00:20:30) 04:13:30 INFO - javascript benchmark 04:13:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8265.633260971077, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3333.30000699853, 3364.5121457388686, 3364.5457863188462, 3372.8988130356097, 3390.2541440882997, 5874.118882167677, 5880.823575292738, 5898.469137777604, 5914.290285165781, 5934.287885453741, 5889.440503152194, 5920.733566989485, 5970.820875373734, 5985.760569577223, 5988.790392336269, 4982.103221420143, 5221.634485586011, 5237.895242095146, 5261.86845328866, 5290.523852853243, 5280.9207861882105, 5334.119870221409, 5347.46525347466, 5349.7592608332525, 5371.677699338033, 5187.610929180289, 5248.317718696583, 5283.28675628789, 5297.682139071668, 5304.124819404794, 5232.7122008289525, 5237.947620523784, 5248.134057880445, 5266.34170728659, 5279.076161671731, 5164.0, 5193.402758682762, 5193.844184674465, 5203.297554830087, 5208.322918020671, 5769.596128271022, 5813.447722466359, 5851.356350801409, 5871.3541510433815, 5924.200232968537, 6355.809325720235, 6373.075903993941, 6379.202599675041, 6387.680615969183, 6391.265004524493, 6409.0, 6415.935840641627, 6422.261439934374, 6425.485961123099, 6438.484921206292, 5837.328707198684, 5891.49922256613, 5911.379305172981, 5950.285965684102, 5956.940430595682, 6555.967220163869, 6562.0, 6571.2771595124495, 6596.505262105361, 6610.405063544208, 6185.752569897154, 6249.6562689052535, 6308.400701933309, 6310.242770867525, 6331.461825744771, 6310.242770867433, 6355.332690067568, 6356.745730170834, 6394.552381333262, 6399.712012959428, 6303.495720342362, 6397.96801015992, 6419.293877673452, 6424.550281480345, 6436.195475565554, 6290.779822706275, 6317.842053948688, 6388.201474815648, 6394.84012899672, 6401.359864013654, 4883.316335713003, 4887.633427492881, 4888.144574699484, 4906.239532872411, 4927.43334516528, 4251.723637963522, 4262.70161088727, 4273.18809426208, 4277.871663850089, 4296.785160741951, 5869.706514674334, 5912.9113063304085, 5951.077582974559, 5957.880842383128, 5987.760489580368, 6396.488280937514, 6403.199600049994, 6404.519661025442, 6423.935760642427, 6433.324500927335, 5867.178594996704, 5925.585209035326, 5925.911111333334, 5937.614055086406, 5960.910586341209, 5358.035553600312, 5371.167469042305, 5404.648697834707, 5412.161115027177, 5444.700541470178, 6634.535582509275, 6650.667466626649, 6675.7997260082275, 6679.198496180489, 6681.899771503528, 6364.713587888464, 6409.070684750592, 6409.647469389229, 6419.646919419477, 6436.935630643634, 6513.8697226056165, 6616.139901812926, 6641.435477984425, 6655.434288085567, 6662.900056499059, 6216.751329946752, 6228.22147231596, 6261.78083767066, 6286.4342209201395, 6286.591371560834, 6437.388448097423, 6462.127612772216, 6472.482201423969, 6475.769603775268, 6477.967610161919, 6127.20346354971, 6162.599431036968, 6225.408586184486, 6239.625622462667, 6247.281562620356, 6204.75904819029, 6215.098810672517, 6222.62664240147, 6234.750609975732, 6250.499960003098, 6229.875402492015, 6238.189035425366, 6246.187995560548, 6255.843603909939, 6264.342244064308, 6208.975519039489, 6239.96880015597, 6276.905846412399, 6291.874162516816, 6302.905456418066, 6050.0017497112485, 6108.0, 6117.235345581802, 6119.816405507842, 6131.877362452815], "value": 5835.844529161223, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [792.8850316704078, 832.6710949175076, 863.8013256950903, 1166.5742004168476, 1181.917265791394, 38246.617533824654, 39008.80495597522, 39184.41223381652, 39257.60742392575, 39364.606353936455, 40390.39414408786, 40710.79644601773, 40835.795821020925, 40882.59117408825, 40907.795461022724, 7030.543014704053, 7103.751368702096, 7106.324899134574, 7216.278372162794, 7415.110186777594, 7342.963285183567, 7416.925830741678, 7418.591977441239, 7425.443091768112, 7456.627168641547, 7366.116066072079, 7430.665620047083, 7457.216992215821, 7457.216992215821, 7464.066991626047, 7388.039554857888, 7404.1855395906405, 7419.962900185518, 7421.035265415516, 7457.403407727369, 7289.453291003196, 7296.0, 7333.706651733924, 7364.889526657104, 7387.852242955165, 38122.42816357757, 38161.61838381609, 38386.0, 38481.80759096215, 38485.23029539421, 3450.3616830886367, 3471.8437670304897, 3489.5638045244345, 3495.353359628477, 3500.8249587520777, 29807.0, 30010.099697009126, 30080.247993800112, 30081.097567073022, 30104.698953010407, 3690.2435000824767, 3702.426123950792, 3736.6076561961145, 3743.513343265358, 3745.9063523412133, 149423.0, 155264.0, 155333.0, 201168.0, 201833.0, 42439.57560424356, 42634.0, 42659.36010959838, 42739.35890961638, 42750.57249427466, 44262.55737442649, 44403.0, 44429.555704442544, 44559.0, 44582.55417445849, 15170.848291517164, 15284.770728439082, 15334.539963801104, 15341.309641066178, 15380.07719536809, 12352.320622365856, 12466.81299780504, 12472.937635311766, 12477.500899964081, 12493.375331233401, 14466.566003019927, 14618.63453413652, 14628.926855365868, 14637.634059148393, 14811.11133331982, 5794.391588883191, 5838.328592211865, 5917.378675239124, 6003.579749417586, 6064.787732429432, 1018.8369860822232, 1019.3934608907688, 1044.9164066874632, 1067.3595842494442, 1077.3320541264309, 25267.494650107263, 25586.0, 25635.74364256371, 25886.352841178745, 25972.0, 1141.3222562832623, 1145.6563031090639, 1159.6636975277074, 1190.9761804763857, 1192.9403529823473, 13121.934390327988, 13477.797833032513, 13632.727345453035, 13691.726165476635, 13782.862171378358, 244353.0, 244648.0, 245879.0, 246354.0, 246369.0, 51956.74021629868, 52372.0, 52793.472065279624, 52975.47024529705, 53089.20366194433, 1460.2114857976785, 1485.5691849363564, 1491.5599898030107, 1511.7581187010026, 1515.8787297016213, 23784.524309514058, 24168.274951751475, 24351.0, 24807.0, 25532.48935021326, 38161.0, 38192.80903595464, 38209.4268585977, 38263.0, 38328.6167138325, 197780.0, 198408.0, 199832.0, 199869.0, 200837.0, 34339.65660343465, 35547.82226088853, 36303.636963631085, 36310.09224769402, 36454.635453645125, 42656.14687706291, 43079.569204307554, 43836.780816095714, 44092.77953610211, 44391.55608444003, 31599.84200078985, 32807.0, 32821.53838462173, 33379.83310083434, 34665.65334346725, 32346.676533234368, 32692.50961235631, 32946.17634559155, 33989.83005084959, 34113.48829767605, 37347.253054938206, 37915.62084379121, 38014.619853802214, 38766.4185037219, 38852.80573597114, 30699.0, 31369.529457057706, 31642.0, 32088.197795055312, 32745.0, 25027.87486062558, 26368.124400383385, 26530.0, 26531.469370612092, 26541.203763887115], "value": 17055.488621349363, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.44450659767665, 505.4137200847018, 506.8859506611013, 523.9449857764937, 527.8020742221667, 20640.277590284324, 21377.0, 21414.35756927293, 22032.33902982909, 24216.878915605397, 24575.877120614416, 24962.0, 25058.74941250587, 25091.74908250917, 25224.873875630597, 5805.593608447411, 5861.912071318912, 5927.962606543859, 5939.762409503614, 5948.821535353946, 5813.0, 5897.970510147443, 5937.851553711149, 5944.583879128462, 5946.0, 5950.464458198761, 5979.730912108944, 6026.2165918430765, 6030.939690603103, 6036.547258955596, 6007.249093863267, 6022.2773267207995, 6036.788712395067, 6041.667708276043, 6049.576529642927, 5582.106862901916, 5602.271704678406, 5605.887882242373, 5617.747201375948, 5618.971905140489, 26918.0, 27669.584956225674, 27910.16269511918, 28180.718192818014, 28183.0, 2160.1359456217483, 2195.5938151442033, 2220.666899965002, 2221.955560888773, 2228.821694264455, 18495.722564161548, 18951.715724264148, 19066.52333691655, 19081.809181908142, 19134.0, 2253.6844841722173, 2274.8976296066717, 2276.1350686739097, 2321.7446080931086, 2327.057541695616, 126698.0, 129432.35283823521, 136794.0, 136959.0, 138175.0, 14046.367913443919, 14063.226522541154, 14378.137311761118, 14611.342489587994, 14685.55943321702, 21606.78393216079, 21907.67138492924, 21951.121955121616, 21951.231706890503, 21960.23139190121, 9289.767755806024, 9407.623695052258, 9554.952225238829, 9572.138507534217, 10341.793164136676, 8721.956390218009, 9056.411333263317, 9135.406198597202, 9211.861822072675, 9316.114969078062, 8768.0, 8973.0, 8985.281177505783, 9043.0, 9089.954550227207, 2534.6071358939394, 2540.517301712706, 2554.272032470737, 2648.3246772073385, 2659.893604255808, 1031.504877658728, 1032.55084038442, 1036.8185567525652, 1060.2419270221828, 1063.8776540697763, 20490.692639610417, 24659.876700616383, 27359.45281094367, 27381.04166354168, 27453.72546274512, 1064.4305296666246, 1073.3988966178965, 1076.5532304093713, 1086.1365214654368, 1101.867775866885, 11334.773304533863, 11803.291802491878, 11839.348835814113, 12043.939780301218, 12229.938850305869, 531297.0, 534711.0, 538675.0, 553404.0, 559775.0, 120312.39843800725, 120492.39753801351, 120650.0, 120696.0, 121321.39339303247, 1225.6935766058486, 1244.8381710377773, 1277.0996447504488, 1281.4105511464645, 1287.575100216926, 21508.89245553762, 22218.88890555537, 22405.88797056004, 22617.208397706658, 23086.42283942915, 55440.445595543526, 55628.0, 55703.721481392335, 56937.0, 58087.12869307048, 69916.95124573034, 75034.0, 77265.61367193128, 77449.0, 77768.61115694385, 16409.753853692444, 17045.829541704425, 17115.229814658618, 17210.0, 17503.824961750728, 18485.53786155357, 18634.81365186385, 18644.16101275473, 18688.34590789316, 18734.437966861016, 15792.447264345692, 15796.526104216891, 15863.206839658202, 15912.363505459653, 16077.035377877364, 13174.736505270033, 14138.575842724735, 14164.716705666035, 14170.787438188641, 14276.57170284893, 16259.26833292481, 16330.836691632932, 16366.099864507567, 16377.099259540839, 16381.508554743377, 16004.19979001022, 16826.242819072926, 16870.325186992384, 16949.474547290803, 17051.829481705023, 14320.355583998537, 14986.47547335838, 15081.924590376977, 15086.321115549606, 15106.697866042838], "value": 11767.936197276049, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.1936876611562, 1444.1153297629376, 1448.7102579484106, 1452.6077958951084, 1465.5603319004304, 12988.22070675759, 13282.402291896864, 13623.386947587358, 13624.182549047051, 13673.316334183275, 13337.799933000988, 13514.864851351484, 13604.387802548885, 13614.319284035784, 13638.0, 2576.9999999999955, 2623.173700284414, 2625.8818353174056, 2626.067745950189, 2626.1727555819953, 2541.5552278351306, 2657.242685834528, 2659.0, 2659.7739192168688, 2660.3349162709324, 2557.9104731334405, 2564.0897481394118, 2585.4441295121546, 2587.611858221263, 2595.377109493727, 2562.859042752648, 2579.780718638899, 2591.106068406397, 2599.0, 2599.896004159831, 2460.052879641333, 2468.9506209875703, 2497.837640553358, 2515.0442831723826, 2524.4193835417773, 12945.676358091028, 13078.673033174151, 13133.212007279593, 13146.21122732639, 13269.469221231138, 7266.491345605809, 7556.886646700304, 7558.848823023509, 7571.3942884569105, 7590.3927685785, 4411.735295882258, 4491.708038977488, 4543.954560454386, 4548.5906268436, 4551.112533056055, 1492.3657445585582, 1494.0662086196128, 1526.7251894658957, 1547.5280039587922, 1603.7594360845849, 20932.790672093237, 21141.68287475689, 21275.36173914785, 21554.784452155436, 22230.777692223033, 6430.292667806538, 6442.162518872517, 6468.126802881551, 6608.636524991076, 6674.799756007327, 15399.769003464957, 15438.305276262596, 15473.303701333241, 15500.30248638814, 15515.767263491056, 7237.493375463772, 7340.0, 7452.776416707507, 7459.179490256068, 7479.326860582573, 6816.420604248694, 6887.862242755117, 6893.724251030003, 6904.3095690430555, 6910.44716422685, 4795.328653988445, 4888.608911287089, 4917.704937703749, 4956.801727930842, 4968.701877887338, 1415.1367665723901, 1426.9500567480295, 1429.978550321746, 1435.253668092586, 1450.8404075551891, 861.1259571534897, 880.4365206267994, 883.5317281840635, 904.4076130134772, 912.9041450647586, 6807.353301436356, 6847.554908930903, 7068.893966590505, 7172.354488096096, 7198.352148306572, 708.9397401220954, 739.7780665800238, 739.9223081576357, 742.9591372474458, 743.0785825576246, 4285.207236661227, 4384.057427653006, 4517.548245175456, 5003.099442100384, 5005.896344266578, 17276.568085797706, 18122.546936326435, 18701.34545290908, 18758.624827503372, 18764.624707505773, 18102.90948545249, 18413.0, 18448.26206951707, 18452.538686532676, 18580.25678972826, 10324.845127323097, 10342.689719308433, 10694.786104277871, 10766.94616526928, 10830.566777328977, 7426.628668566442, 7626.504277221963, 7905.881411778943, 8150.75547733569, 8188.0993090758775, 16224.26990785441, 16286.67426651484, 16312.592185195464, 16771.32914683399, 16874.578135546217, 16295.755563666791, 16650.916745416194, 16819.0, 16918.407855724992, 16928.068956207528, 10816.459177041274, 10916.836247456453, 10978.737445193905, 10988.505517251582, 11007.724806879893, 12201.389930503618, 12313.753724925631, 12415.379231038592, 12419.44112514921, 12435.440405181607, 10209.489525523843, 10518.263721539419, 10525.684229473129, 10776.29954052984, 10952.452377381258, 10021.699349019542, 10098.293119481566, 10152.949235253776, 10290.742731431774, 10297.227707921786, 9055.547222638974, 9162.175404213385, 9231.630734770533, 9359.251259899056, 9373.20327772147, 6473.320301368289, 6624.503162262753, 6747.460203183831, 6917.515773895779, 7114.928850711427, 6692.5315227935525, 6717.395434410731, 6746.156730408699, 6899.862002759816, 7030.683619237249], "value": 6076.003154173422, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.23786066150586, 448.68816172759927, 452.93658887755697, 455.382956094492, 457.7665390650767, 6365.395287447696, 6387.520935929806, 6392.488600911927, 6403.903941440871, 6409.583377080487, 5945.346011938684, 6210.31686514483, 6218.347073557279, 6228.283747369054, 6228.346023667517, 4790.616750659948, 4793.640476964224, 4805.111054454919, 4807.5432833880905, 4808.879778005543, 4816.157172494817, 4817.566419022287, 4820.373351464323, 4829.565339119478, 4834.734089625069, 4796.808127674906, 4804.111239420701, 4821.108095002436, 4824.348712923746, 4829.830955916544, 4822.421309442854, 4835.540623640749, 4838.322634831126, 4838.879028024292, 4839.516048395168, 4288.721233119837, 4294.463192100988, 4310.935335969963, 4313.870583882489, 4316.891837876755, 6092.573519853612, 6133.325334213233, 6159.661218632973, 6179.28938172107, 6196.907046394308, 5718.857028574277, 5736.770529178828, 5744.8851022979725, 5750.396208398141, 5760.164776107441, 6603.3396660334065, 6666.833329166761, 6694.933050669529, 6704.698288577026, 6736.663166841688, 4789.640776941708, 4806.279058141272, 4811.518848115161, 4818.132736107499, 4819.903601927942, 6588.637624930627, 6932.341427564374, 6943.1321084863885, 6954.617496037716, 6999.615021173833, 4891.0, 4902.142125128088, 4913.65604407688, 4927.655064145547, 4933.605311575066, 4953.281774142729, 4963.461326988645, 4967.602591792648, 4969.726665033458, 4994.355249617817, 5541.667499950016, 5649.971750141223, 5654.180143879114, 5668.121441176624, 5668.744906479218, 6658.400743933069, 6661.26726060133, 6680.265170831205, 6686.7993960181275, 6694.330566943267, 1705.7867766529184, 1716.5022143578221, 1723.4657256250603, 1727.4385824607052, 1733.7832770903638, 1144.582227486978, 1183.923045002072, 1190.4464424042687, 1191.5710344276054, 1201.9218750781172, 6264.843378915563, 6270.247570291503, 6274.560780745304, 6274.717637706314, 6297.4647154992335, 6793.762218322335, 6816.216135144522, 6821.192384018239, 6823.55646882951, 6828.2488926218075, 6209.534284928648, 6213.471854892295, 6261.186045814015, 6270.0, 6271.3728627136925, 3618.222082252328, 3624.444766439654, 3630.618785027587, 3639.8180090995343, 3654.8172591370326, 7062.329078737512, 7077.267413395167, 7098.645067746592, 7108.289171082851, 7108.68010939509, 6918.5502942308585, 6943.6875340609795, 6990.755323563651, 6991.8601627967155, 6999.825004374931, 7035.100522858799, 7058.505904586629, 7077.716891324392, 7088.326608972139, 7107.218205997337, 6765.25582185969, 6806.455483561403, 6814.863702725818, 6876.965615172092, 6884.345987131214, 6371.87256254863, 6764.492663050192, 6773.593584384953, 6776.491763117688, 6802.0, 7016.649167541705, 7065.869460886233, 7077.5399599025895, 7094.716211351488, 7110.85778284421, 4873.390826146731, 4911.778969946289, 4915.827946021872, 4923.163062279493, 4940.901181976412, 6709.0, 6798.694058767466, 6823.147106611674, 6905.827354316182, 6920.307969203241, 6666.300038496082, 6672.232693240339, 6683.699233534406, 6689.331066893272, 6706.362895524917, 6656.866862662817, 6660.83347916306, 6683.732650693918, 6693.330666933268, 6711.899321510279, 6670.9332906670315, 6680.498962577729, 6686.866262674622, 6687.264400915993, 6696.0, 6664.166979127609, 6692.765753198614, 6726.192856857208, 6726.831829204309, 6731.394174524316, 6528.869422611616, 6574.474042076718, 6600.867982640416, 6605.943049112119, 6606.141201643948], "value": 5097.301739568651, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [815.991840081599, 833.720703564306, 845.1590667286049, 845.8562044452442, 856.0284077571956, 17256.13719314034, 17483.475495735132, 17538.21078051489, 19637.607247855034, 20749.688754668656, 18857.43427697168, 18927.053647317647, 19118.13968371423, 19134.330298439556, 19151.712724309113, 967.6274634265806, 993.4933184076101, 993.8509223616479, 998.4658207858797, 998.6454808542971, 968.8837339519232, 996.1482932093065, 1002.2483137646765, 1008.4100801031369, 1008.9848652270222, 1026.0, 1026.3892983674702, 1029.1149611334247, 1029.5881647341048, 1035.2339268940966, 1015.5937624950005, 1018.5263852308713, 1020.1532727835915, 1020.6274709730932, 1021.2953062387004, 755.8186035351531, 758.4614923404334, 759.6050053971903, 761.2235519769804, 765.6095391350395, 16683.66632667352, 16774.412895548598, 16859.831401685948, 16880.409185678443, 16963.151842407955, 18309.0, 18395.35616253438, 18709.62580748391, 18798.624027519374, 18829.529261768428, 14721.484748033767, 14838.851611483855, 14856.702865942729, 14972.47596334134, 15029.624259393493, 3403.149212696826, 3435.347284016029, 3464.082018265162, 3474.0793689672255, 3510.350585141757, 95825.5208723959, 98207.0, 101794.49102754438, 103167.48416257945, 103634.48182759114, 14040.85959140416, 14507.057041292283, 14744.115353078849, 15067.773983390258, 15085.3211605478, 27300.180994570193, 27635.585466218025, 27770.861145694143, 27854.860725696646, 27866.72133278682, 8153.6738530458115, 8356.247937685637, 8366.330693544502, 8405.41162118658, 8514.446560973516, 3815.1606646537716, 3911.902202444962, 3912.5109361329833, 3917.373220284741, 3934.5475270344277, 4527.411436513298, 4599.310103484504, 4611.423572053493, 4618.122556714214, 4627.699199552018, 920.8112336970905, 922.257582645963, 929.1823195587839, 933.0622724162309, 934.4113208678625, 690.5649440852231, 719.9964000180071, 720.7657511308846, 729.4055344894001, 739.2164305835831, 11877.762444751057, 12760.425780839885, 12785.61643150707, 12851.807222891664, 13548.187108773505, 710.1691021504852, 721.3832173491589, 732.772840419461, 734.13738856843, 736.1019556141499, 5645.181448689917, 5839.445252700986, 6013.398660133952, 6147.96926015376, 6243.7814676486105, 111864.0, 112685.74628507384, 113913.43043284897, 114607.0, 117788.0, 101069.15388944065, 104099.0, 105090.47454762677, 106150.0, 110592.4470377643, 84720.45838624852, 85816.99999999875, 86312.56843715742, 86537.56731216429, 88174.1182588166, 11333.4492782432, 11369.715757106138, 11513.654590362303, 11548.133889958455, 11585.536578536765, 42541.0, 43047.56952430436, 43094.0, 43185.56814431815, 43893.341599876665, 55141.72429137828, 56967.43032569787, 57133.42866571281, 57698.0, 58329.4167058341, 16303.26635301438, 16351.591210219363, 16555.337786488406, 16612.83387166113, 16753.91623041877, 17902.194401252236, 18070.277188912296, 18123.45629631113, 19825.702614461083, 21145.471363216042, 19469.902650487224, 19673.508162296057, 19870.701939471208, 20002.499937501678, 20393.796062039783, 18970.810291896905, 19373.0, 19582.412527624194, 19728.802711972698, 19965.20139194416, 18762.343317983807, 18873.90563047176, 18905.71641425407, 19110.617787643892, 19226.230950762372, 11989.700257493632, 12131.393430328624, 12189.390530473618, 12489.000879929765, 12920.935395323339, 12920.353982301036, 13230.801537976746, 13554.72890542164, 13606.319684015958, 13608.183508989492], "value": 8790.279075414523, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1515.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 110.0, 103.0, 107.0, 108.0, 109.0, 108.0, 100.0, 108.0, 109.0], "value": 106.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 149.0, 184.0, 116.0, 154.0, 145.0, 117.0, 164.0, 118.0], "value": 140.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 161.0, 162.0, 163.0, 165.0, 165.0, 164.0, 177.0, 169.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 76.0, 175.0, 74.0, 73.0, 75.0, 72.0, 165.0, 73.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 138.0, 82.0, 81.0, 81.0, 132.0, 83.0, 82.0, 131.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 114.0, 114.0, 114.0, 114.0, 116.0, 117.0, 114.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 150.0, 149.0, 148.0, 148.0, 152.0, 151.0, 148.0, 148.0, 147.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 99.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 49.0, 53.0, 49.0, 49.0, 52.0, 49.0, 49.0, 48.0, 49.0], "value": 50.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 55.0, 56.0, 54.0, 56.0, 58.0, 55.0, 55.0, 55.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 79.0, 80.0, 81.0, 79.0, 79.0, 80.0, 99.0, 81.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 127.0, 139.0, 123.0, 126.0, 121.0, 127.0, 127.0, 121.0, 124.0], "value": 126.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 175.0, 177.0, 174.0, 172.0, 170.0, 174.0, 182.0, 174.0, 183.0], "value": 177.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 65.0, 66.0, 63.0, 65.0, 62.0, 62.0, 65.0, 62.0], "value": 63.9, "unit": "score"}]}]} 04:13:30 INFO - Return code: 0 04:13:31 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:13:31 INFO - # TBPL SUCCESS # 04:13:31 INFO - Running post-action listener: _resource_record_post_action 04:13:31 INFO - [mozharness: 2017-06-08 11:13:31.041913Z] Finished run-tests step (success) 04:13:31 INFO - Running post-run listener: _resource_record_post_run 04:13:31 INFO - Total resource usage - Wall time: 1247s; CPU: 13.0%; Read bytes: 12288; Write bytes: 422092800; Read time: 284; Write time: 240308 04:13:31 INFO - TinderboxPrint: CPU usage
12.5% 04:13:31 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 284 04:13:31 INFO - TinderboxPrint: I/O write bytes / time
422,092,800 / 240,308 04:13:31 INFO - TinderboxPrint: CPU idle
8,702.4 (87.4%) 04:13:31 INFO - TinderboxPrint: CPU user
1,198.8 (12.0%) 04:13:31 INFO - TinderboxPrint: Swap in / out
0 / 0 04:13:31 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 103219200; Read time: 80; Write time: 78764 04:13:31 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 04:13:31 INFO - run-tests - Wall time: 1231s; CPU: 13.0%; Read bytes: 4096; Write bytes: 318873600; Read time: 184; Write time: 161544 04:13:31 INFO - Running post-run listener: _upload_blobber_files 04:13:31 INFO - Blob upload gear active. 04:13:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:13:31 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 04:13:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:13:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:13:32 INFO - (blobuploader) - INFO - Open directory for files ... 04:13:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:13:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:13:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:32 INFO - (blobuploader) - INFO - Done attempting. 04:13:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:13:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:13:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:33 INFO - (blobuploader) - INFO - Done attempting. 04:13:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:13:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:13:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:34 INFO - (blobuploader) - INFO - Done attempting. 04:13:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:13:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:13:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:13:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:13:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:13:38 INFO - (blobuploader) - INFO - Done attempting. 04:13:38 INFO - (blobuploader) - INFO - Iteration through files over. 04:13:38 INFO - Return code: 0 04:13:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:13:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:13:38 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/21f96addbd6a3333704f456f4c63c76ba14d6317f28a904e834b3c3634e4c786fa3229a4e6affe83a7d43802971a5634d689596ab18ca7e328752ef1f451eb54", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a6e5927d0e277113a5597e08be39c3b6232f9649cd5701511dd12e715b76e2cffb5ca4b97a8db01bd52a76dfdd163819eb822d14f79b33891c92ca162a2b5d8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3ce1c7039316186a30ecb2ecfed2690649ae46301c51084546e01084ad01e950173d265ac9c4c4c093bbbdbe217a1870449c91ab1e5fb609fa69639819cf1c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cd2ff17c1eec0c83b8cef958dba11302d50ea7dcf26494f9a175025855d56ec5d44d3fb0eccbd442b8ec2479f91b3beecca76cc0d8e4aa527dfb09b704ad4518"} 04:13:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:13:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:13:38 INFO - Contents: 04:13:38 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/21f96addbd6a3333704f456f4c63c76ba14d6317f28a904e834b3c3634e4c786fa3229a4e6affe83a7d43802971a5634d689596ab18ca7e328752ef1f451eb54", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a6e5927d0e277113a5597e08be39c3b6232f9649cd5701511dd12e715b76e2cffb5ca4b97a8db01bd52a76dfdd163819eb822d14f79b33891c92ca162a2b5d8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3ce1c7039316186a30ecb2ecfed2690649ae46301c51084546e01084ad01e950173d265ac9c4c4c093bbbdbe217a1870449c91ab1e5fb609fa69639819cf1c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cd2ff17c1eec0c83b8cef958dba11302d50ea7dcf26494f9a175025855d56ec5d44d3fb0eccbd442b8ec2479f91b3beecca76cc0d8e4aa527dfb09b704ad4518"} 04:13:38 INFO - Running post-run listener: copy_logs_to_upload_dir 04:13:38 INFO - Copying logs to upload dir... 04:13:38 INFO - mkdir: /builds/slave/test/build/upload/logs 04:13:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1304.534002 ========= master_lag: 0.75 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 45 secs) (at 2017-06-08 04:13:37.073316) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-08 04:13:37.076589) ========= 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=6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/21f96addbd6a3333704f456f4c63c76ba14d6317f28a904e834b3c3634e4c786fa3229a4e6affe83a7d43802971a5634d689596ab18ca7e328752ef1f451eb54", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a6e5927d0e277113a5597e08be39c3b6232f9649cd5701511dd12e715b76e2cffb5ca4b97a8db01bd52a76dfdd163819eb822d14f79b33891c92ca162a2b5d8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3ce1c7039316186a30ecb2ecfed2690649ae46301c51084546e01084ad01e950173d265ac9c4c4c093bbbdbe217a1870449c91ab1e5fb609fa69639819cf1c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cd2ff17c1eec0c83b8cef958dba11302d50ea7dcf26494f9a175025855d56ec5d44d3fb0eccbd442b8ec2479f91b3beecca76cc0d8e4aa527dfb09b704ad4518"} build_url:https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011223 build_url: 'https://queue.taskcluster.net/v1/task/QIplsfJJRlOrkuWgUKpF5Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/21f96addbd6a3333704f456f4c63c76ba14d6317f28a904e834b3c3634e4c786fa3229a4e6affe83a7d43802971a5634d689596ab18ca7e328752ef1f451eb54", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a6e5927d0e277113a5597e08be39c3b6232f9649cd5701511dd12e715b76e2cffb5ca4b97a8db01bd52a76dfdd163819eb822d14f79b33891c92ca162a2b5d8b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f3ce1c7039316186a30ecb2ecfed2690649ae46301c51084546e01084ad01e950173d265ac9c4c4c093bbbdbe217a1870449c91ab1e5fb609fa69639819cf1c1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cd2ff17c1eec0c83b8cef958dba11302d50ea7dcf26494f9a175025855d56ec5d44d3fb0eccbd442b8ec2479f91b3beecca76cc0d8e4aa527dfb09b704ad4518"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-06-08 04:13:37.108165) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 04:13:37.108453) ========= 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=6d15e502d8e29d5d2676d664000001c3-1496917269.543810-420060074 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004449 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-06-08 04:13:37.188677) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-08 04:13:37.188969) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-06-08 04:13:37.192269) ========= ========= Total master_lag: 0.90 =========