builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-018 starttime: 1495676736.78 results: success (0) revision: f81bcc23d37d7bec48f08b19a9327e93c54d37b5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-24 18:45:36.778848) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-24 18:45:36.779293) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-24 18:45:36.779573) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-24 18:45:36.792738) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 18:45:36.793037) ========= 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=62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-24 18:45:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2017-05-24 18:45:37 (46.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.173185 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 18:45:36.977083) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 18:45:36.977479) ========= 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=62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018201 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 18:45:37.028085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 18:45:37.028462) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f81bcc23d37d7bec48f08b19a9327e93c54d37b5 --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 f81bcc23d37d7bec48f08b19a9327e93c54d37b5 --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=62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-24 18:45:37,322 truncating revision to first 12 chars 2017-05-24 18:45:37,322 Setting DEBUG logging. 2017-05-24 18:45:37,322 attempt 1/10 2017-05-24 18:45:37,322 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f81bcc23d37d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-24 18:45:37,652 unpacking tar archive at: mozilla-central-f81bcc23d37d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.624789 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 18:45:37.666409) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-24 18:45:37.666729) ========= script_repo_revision: f81bcc23d37d7bec48f08b19a9327e93c54d37b5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-24 18:45:37.667106) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-24 18:45:37.667378) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-24 18:45:37.677114) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-05-24 18:45:37.677496) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:45:38 INFO - MultiFileLogger online at 20170524 18:45:38 in /builds/slave/test 18:45:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:45:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:45:38 INFO - {'append_to_log': False, 18:45:38 INFO - 'base_work_dir': '/builds/slave/test', 18:45:38 INFO - 'blob_upload_branch': 'Firefox', 18:45:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:45:38 INFO - 'branch': 'Firefox', 18:45:38 INFO - 'buildbot_json_path': 'buildprops.json', 18:45:38 INFO - 'config_files': ('talos/linux_config.py',), 18:45:38 INFO - 'default_actions': ('clobber', 18:45:38 INFO - 'read-buildbot-config', 18:45:38 INFO - 'download-and-extract', 18:45:38 INFO - 'populate-webroot', 18:45:38 INFO - 'create-virtualenv', 18:45:38 INFO - 'install', 18:45:38 INFO - 'run-tests'), 18:45:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:45:38 INFO - 'download_minidump_stackwalk': True, 18:45:38 INFO - 'download_symbols': 'ondemand', 18:45:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:45:38 INFO - 'tooltool.py': '/tools/tooltool.py', 18:45:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:45:38 INFO - '/tools/misc-python/virtualenv.py')}, 18:45:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:45:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:45:38 INFO - 'gecko_profile': False, 18:45:38 INFO - 'gecko_profile_interval': 0, 18:45:38 INFO - 'installer_path': 'installer.exe', 18:45:38 INFO - 'log_level': 'info', 18:45:38 INFO - 'log_name': 'talos', 18:45:38 INFO - 'log_to_console': True, 18:45:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:45:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:45:38 INFO - 'opt_config_files': (), 18:45:38 INFO - 'pip_index': False, 18:45:38 INFO - 'suite': 'dromaeojs-e10s', 18:45:38 INFO - 'system_bits': '32', 18:45:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:45:38 INFO - 'title': 'talos-linux64-ix-018', 18:45:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:45:38 INFO - 'use_talos_json': True, 18:45:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:45:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:45:38 INFO - 'work_dir': 'build'} 18:45:38 INFO - [mozharness: 2017-05-25 01:45:38.077619Z] Running clobber step. 18:45:38 INFO - Running pre-action listener: _resource_record_pre_action 18:45:38 INFO - Running main action method: clobber 18:45:38 INFO - rmtree: /builds/slave/test/build 18:45:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:45:39 INFO - Running post-action listener: _resource_record_post_action 18:45:39 INFO - [mozharness: 2017-05-25 01:45:39.149236Z] Finished clobber step (success) 18:45:39 INFO - [mozharness: 2017-05-25 01:45:39.149337Z] Running read-buildbot-config step. 18:45:39 INFO - Running pre-action listener: _resource_record_pre_action 18:45:39 INFO - Running main action method: read_buildbot_config 18:45:39 INFO - Using buildbot properties: 18:45:39 INFO - { 18:45:39 INFO - "project": "", 18:45:39 INFO - "product": "firefox", 18:45:39 INFO - "who": "ryanvm@gmail.com", 18:45:39 INFO - "installer_path": "public/build/target.tar.bz2", 18:45:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 18:45:39 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 18:45:39 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 18:45:39 INFO - "stage_platform": "linux64-stylo", 18:45:39 INFO - "basedir": "/builds/slave/test", 18:45:39 INFO - "buildnumber": 108, 18:45:39 INFO - "platform": "ubuntu64_hw_stylo", 18:45:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:45:39 INFO - "slavebuilddir": "test", 18:45:39 INFO - "taskId": "Cr2eqO17S-SHhzEQG1YeZg", 18:45:39 INFO - "branch": "mozilla-central", 18:45:39 INFO - "script_repo_revision": "production", 18:45:39 INFO - "revision": "f81bcc23d37d7bec48f08b19a9327e93c54d37b5", 18:45:39 INFO - "slavename": "talos-linux64-ix-018", 18:45:39 INFO - "repo_path": "mozilla-central" 18:45:39 INFO - } 18:45:39 INFO - Finding installer, test and symbols from parent task. 18:45:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cr2eqO17S-SHhzEQG1YeZg'}, attempt #1 18:45:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cr2eqO17S-SHhzEQG1YeZg'}, attempt #1 18:45:40 INFO - Task dependencies: EV_sYQgUTue77nB9Vgxa3Q 18:45:40 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q'}, attempt #1 18:45:40 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/target.tar.bz2 18:45:40 INFO - Set test_url: https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/test_packages.json 18:45:40 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/target.crashreporter-symbols.zip 18:45:40 INFO - Running post-action listener: _resource_record_post_action 18:45:40 INFO - [mozharness: 2017-05-25 01:45:40.523543Z] Finished read-buildbot-config step (success) 18:45:40 INFO - [mozharness: 2017-05-25 01:45:40.523762Z] Running download-and-extract step. 18:45:40 INFO - Running pre-action listener: _resource_record_pre_action 18:45:40 INFO - Running main action method: download_and_extract 18:45:40 INFO - mkdir: /builds/slave/test/build/tests 18:45:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:45:40 INFO - trying https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/target.test_packages.json 18:45:40 INFO - Downloading https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 18:45:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 18:45:41 INFO - Downloaded 989 bytes. 18:45:41 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 18:45:41 INFO - Using the following test package requirements: 18:45:41 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 18:45:41 INFO - u'common': [u'target.common.tests.zip'], 18:45:41 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 18:45:41 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 18:45:41 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 18:45:41 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 18:45:41 INFO - u'mozbase': [u'target.common.tests.zip'], 18:45:41 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 18:45:41 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 18:45:41 INFO - u'web-platform': [u'target.common.tests.zip', 18:45:41 INFO - u'target.web-platform.tests.tar.gz'], 18:45:41 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 18:45:41 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 18:45:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/target.common.tests.zip 18:45:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:45:41 INFO - Fetch https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/target.common.tests.zip into memory 18:45:42 INFO - Content-Length response header: 63524954 18:45:42 INFO - Bytes received: 63524954 18:45:53 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 18:45:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/target.common.tests.zip 18:45:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 18:45:53 INFO - Fetch https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/target.common.tests.zip into memory 18:45:54 INFO - Content-Length response header: 63524954 18:45:54 INFO - Bytes received: 63524954 18:46:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/target.talos.tests.zip 18:46:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 18:46:05 INFO - Fetch https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/target.talos.tests.zip into memory 18:46:06 INFO - Content-Length response header: 14411859 18:46:06 INFO - Bytes received: 14411859 18:46:06 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')]} 18:46:06 INFO - trying https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/target.tar.bz2 18:46:06 INFO - Downloading https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 18:46:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 18:46:07 INFO - Downloaded 55603726 bytes. 18:46:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/target.tar.bz2 18:46:07 INFO - mkdir: /builds/slave/test/properties 18:46:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:46:07 INFO - Writing to file /builds/slave/test/properties/build_url 18:46:07 INFO - Contents: 18:46:07 INFO - build_url:https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/target.tar.bz2 18:46:07 INFO - Running post-action listener: _resource_record_post_action 18:46:07 INFO - Running post-action listener: set_extra_try_arguments 18:46:07 INFO - [mozharness: 2017-05-25 01:46:07.964900Z] Finished download-and-extract step (success) 18:46:07 INFO - [mozharness: 2017-05-25 01:46:07.965004Z] Running populate-webroot step. 18:46:07 INFO - Running pre-action listener: _resource_record_pre_action 18:46:07 INFO - Running main action method: populate_webroot 18:46:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:46:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:46:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:46:07 INFO - '--tppagecycles', 18:46:07 INFO - '7'], 18:46:07 INFO - 'tests': ['tsvgm']}}, 18:46:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:46:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:46:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:46:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:46:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:46:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:46:07 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:46:07 INFO - 'talos_options': ['--disable-e10s'], 18:46:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:46:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:46:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:46:07 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:46:07 INFO - 'talos_options': ['--disable-e10s'], 18:46:07 INFO - 'tests': ['damp', 'tps']}, 18:46:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:46:07 INFO - 'tests': ['damp', 'tps']}, 18:46:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:46:07 INFO - 'tests': ['dromaeo_dom']}, 18:46:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:46:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:46:07 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 18:46:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 18:46:07 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 18:46:07 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 18:46:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:46:07 INFO - 'tests': ['a11yr', 18:46:07 INFO - 'ts_paint', 18:46:07 INFO - 'tpaint', 18:46:07 INFO - 'sessionrestore', 18:46:07 INFO - 'sessionrestore_no_auto_restore', 18:46:07 INFO - 'tabpaint']}, 18:46:07 INFO - 'other-e10s': {'tests': ['a11yr', 18:46:07 INFO - 'ts_paint', 18:46:07 INFO - 'tpaint', 18:46:07 INFO - 'sessionrestore', 18:46:07 INFO - 'sessionrestore_no_auto_restore', 18:46:07 INFO - 'tabpaint']}, 18:46:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:46:07 INFO - 'ts_paint', 18:46:07 INFO - 'tpaint', 18:46:07 INFO - 'sessionrestore', 18:46:07 INFO - 'sessionrestore_no_auto_restore', 18:46:07 INFO - 'tabpaint']}, 18:46:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:46:07 INFO - 'ts_paint', 18:46:07 INFO - 'tpaint', 18:46:07 INFO - 'sessionrestore', 18:46:07 INFO - 'sessionrestore_no_auto_restore', 18:46:07 INFO - 'tabpaint']}, 18:46:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:46:07 INFO - 'tests': ['a11yr', 18:46:07 INFO - 'ts_paint', 18:46:07 INFO - 'tpaint', 18:46:07 INFO - 'sessionrestore', 18:46:07 INFO - 'sessionrestore_no_auto_restore', 18:46:07 INFO - 'tabpaint']}, 18:46:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:46:07 INFO - 'tests': ['a11yr', 18:46:07 INFO - 'ts_paint', 18:46:07 INFO - 'tpaint', 18:46:07 INFO - 'sessionrestore', 18:46:07 INFO - 'sessionrestore_no_auto_restore', 18:46:07 INFO - 'tabpaint']}, 18:46:07 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 18:46:07 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 18:46:07 INFO - 'bloom_basic_ref']}, 18:46:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:46:07 INFO - 'tests': ['tsvgx', 18:46:07 INFO - 'tsvgr_opacity', 18:46:07 INFO - 'tart', 18:46:07 INFO - 'tscrollx', 18:46:07 INFO - 'cart', 18:46:07 INFO - 'tsvg_static']}, 18:46:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:46:07 INFO - 'tsvgr_opacity', 18:46:07 INFO - 'tart', 18:46:07 INFO - 'tscrollx', 18:46:07 INFO - 'cart', 18:46:07 INFO - 'tsvg_static']}, 18:46:07 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:46:07 INFO - 'talos_options': ['--disable-e10s'], 18:46:07 INFO - 'tests': ['tp5o']}, 18:46:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:46:07 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:46:07 INFO - 'talos_options': ['--disable-e10s', 18:46:07 INFO - '--xperf_path', 18:46:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:46:07 INFO - 'tests': ['tp5n']}, 18:46:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:46:07 INFO - 'talos_options': ['--xperf_path', 18:46:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:46:07 INFO - 'tests': ['tp5n']}}, 18:46:07 INFO - 'talos.zip': {'path': '', 18:46:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:46:07 INFO - Running post-action listener: _resource_record_post_action 18:46:07 INFO - [mozharness: 2017-05-25 01:46:07.979202Z] Finished populate-webroot step (success) 18:46:07 INFO - [mozharness: 2017-05-25 01:46:07.979291Z] Running create-virtualenv step. 18:46:07 INFO - Running pre-action listener: _resource_record_pre_action 18:46:07 INFO - Running main action method: create_virtualenv 18:46:07 INFO - Creating virtualenv /builds/slave/test/build/venv 18:46:07 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 18:46:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:46:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:46:08 INFO - Using real prefix '/usr' 18:46:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:46:08 INFO - Installing distribute.............................................................................................................................................................................................done. 18:46:10 INFO - Installing pip.................done. 18:46:10 INFO - Return code: 0 18:46:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:46:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:46:10 INFO - Reading from file tmpfile_stdout 18:46:10 INFO - Output received: 18:46:10 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) 18:46:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:46:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19877a0>, '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 0x19886a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1988b30>, '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': '62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060', '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 18:46:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:46:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:46:10 INFO - Using env: {'DISPLAY': ':0', 18:46:10 INFO - 'HOME': '/home/cltbld', 18:46:10 INFO - 'LANG': 'en_US.UTF-8', 18:46:10 INFO - 'LANGUAGE': 'en_US:en', 18:46:10 INFO - 'LOGNAME': 'cltbld', 18:46:10 INFO - 'MAIL': '/var/mail/cltbld', 18:46:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:10 INFO - 'MOZ_NO_REMOTE': '1', 18:46:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:10 INFO - 'NO_EM_RESTART': '1', 18:46:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:10 INFO - 'PWD': '/builds/slave/test', 18:46:10 INFO - 'SHELL': '/bin/bash', 18:46:10 INFO - 'SHLVL': '1', 18:46:10 INFO - 'TERM': 'linux', 18:46:10 INFO - 'TMOUT': '86400', 18:46:10 INFO - 'USER': 'cltbld', 18:46:10 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060', 18:46:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:10 INFO - '_': '/tools/buildbot/bin/python'} 18:46:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:11 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 18:46:11 INFO - Cleaning up... 18:46:11 INFO - Return code: 0 18:46:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19877a0>, '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 0x19886a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1988b30>, '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': '62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060', '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 18:46:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:46:11 INFO - Using env: {'DISPLAY': ':0', 18:46:11 INFO - 'HOME': '/home/cltbld', 18:46:11 INFO - 'LANG': 'en_US.UTF-8', 18:46:11 INFO - 'LANGUAGE': 'en_US:en', 18:46:11 INFO - 'LOGNAME': 'cltbld', 18:46:11 INFO - 'MAIL': '/var/mail/cltbld', 18:46:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:11 INFO - 'MOZ_NO_REMOTE': '1', 18:46:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:11 INFO - 'NO_EM_RESTART': '1', 18:46:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:11 INFO - 'PWD': '/builds/slave/test', 18:46:11 INFO - 'SHELL': '/bin/bash', 18:46:11 INFO - 'SHLVL': '1', 18:46:11 INFO - 'TERM': 'linux', 18:46:11 INFO - 'TMOUT': '86400', 18:46:11 INFO - 'USER': 'cltbld', 18:46:11 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060', 18:46:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:11 INFO - '_': '/tools/buildbot/bin/python'} 18:46:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:11 INFO - Downloading/unpacking psutil>=3.1.1 18:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:46:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:46:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:46:12 INFO - Installing collected packages: psutil 18:46:12 INFO - Running setup.py install for psutil 18:46:12 INFO - building 'psutil._psutil_linux' extension 18:46:12 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 18:46:12 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 18:46:12 INFO - building 'psutil._psutil_posix' extension 18:46:12 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 18:46:12 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 18:46:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:46:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:46:12 INFO - Successfully installed psutil 18:46:13 INFO - Cleaning up... 18:46:13 INFO - Return code: 0 18:46:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:13 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 0x16171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19877a0>, '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 0x19886a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1988b30>, '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': '62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060', '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 18:46:13 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 18:46:13 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 18:46:13 INFO - Using env: {'DISPLAY': ':0', 18:46:13 INFO - 'HOME': '/home/cltbld', 18:46:13 INFO - 'LANG': 'en_US.UTF-8', 18:46:13 INFO - 'LANGUAGE': 'en_US:en', 18:46:13 INFO - 'LOGNAME': 'cltbld', 18:46:13 INFO - 'MAIL': '/var/mail/cltbld', 18:46:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:13 INFO - 'MOZ_NO_REMOTE': '1', 18:46:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:13 INFO - 'NO_EM_RESTART': '1', 18:46:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:13 INFO - 'PWD': '/builds/slave/test', 18:46:13 INFO - 'SHELL': '/bin/bash', 18:46:13 INFO - 'SHLVL': '1', 18:46:13 INFO - 'TERM': 'linux', 18:46:13 INFO - 'TMOUT': '86400', 18:46:13 INFO - 'USER': 'cltbld', 18:46:13 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060', 18:46:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:13 INFO - '_': '/tools/buildbot/bin/python'} 18:46:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:46:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:46:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:46:14 INFO - Installing collected packages: mozsystemmonitor 18:46:14 INFO - Running setup.py install for mozsystemmonitor 18:46:14 INFO - Successfully installed mozsystemmonitor 18:46:14 INFO - Cleaning up... 18:46:14 INFO - Return code: 0 18:46:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:46:14 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')]} 18:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:14 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')]} 18:46:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:14 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 0x16171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19877a0>, '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 0x19886a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1988b30>, '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': '62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060', '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 18:46:14 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 18:46:14 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 18:46:14 INFO - Using env: {'DISPLAY': ':0', 18:46:14 INFO - 'HOME': '/home/cltbld', 18:46:14 INFO - 'LANG': 'en_US.UTF-8', 18:46:14 INFO - 'LANGUAGE': 'en_US:en', 18:46:14 INFO - 'LOGNAME': 'cltbld', 18:46:14 INFO - 'MAIL': '/var/mail/cltbld', 18:46:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:14 INFO - 'MOZ_NO_REMOTE': '1', 18:46:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:14 INFO - 'NO_EM_RESTART': '1', 18:46:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:14 INFO - 'PWD': '/builds/slave/test', 18:46:14 INFO - 'SHELL': '/bin/bash', 18:46:14 INFO - 'SHLVL': '1', 18:46:14 INFO - 'TERM': 'linux', 18:46:14 INFO - 'TMOUT': '86400', 18:46:14 INFO - 'USER': 'cltbld', 18:46:14 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060', 18:46:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:14 INFO - '_': '/tools/buildbot/bin/python'} 18:46:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:14 INFO - Downloading/unpacking jsonschema==2.5.1 18:46:14 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 18:46:14 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 18:46:14 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 18:46:14 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 18:46:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:46:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:15 INFO - Downloading functools32-3.2.3-2.tar.gz 18:46:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:46:16 INFO - warning: no files found matching '*.txt' 18:46:16 INFO - no previously-included directories found matching 'build' 18:46:16 INFO - no previously-included directories found matching 'dist' 18:46:16 INFO - no previously-included directories found matching '.git*' 18:46:16 INFO - Installing collected packages: jsonschema, functools32 18:46:16 INFO - Running setup.py install for functools32 18:46:16 INFO - warning: no files found matching '*.txt' 18:46:16 INFO - no previously-included directories found matching 'build' 18:46:16 INFO - no previously-included directories found matching 'dist' 18:46:16 INFO - no previously-included directories found matching '.git*' 18:46:16 INFO - Successfully installed jsonschema functools32 18:46:16 INFO - Cleaning up... 18:46:16 INFO - Return code: 0 18:46:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:46:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19877a0>, '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 0x19886a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1988b30>, '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': '62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060', '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 18:46:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:46:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:46:16 INFO - Using env: {'DISPLAY': ':0', 18:46:16 INFO - 'HOME': '/home/cltbld', 18:46:16 INFO - 'LANG': 'en_US.UTF-8', 18:46:16 INFO - 'LANGUAGE': 'en_US:en', 18:46:16 INFO - 'LOGNAME': 'cltbld', 18:46:16 INFO - 'MAIL': '/var/mail/cltbld', 18:46:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:16 INFO - 'MOZ_NO_REMOTE': '1', 18:46:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:16 INFO - 'NO_EM_RESTART': '1', 18:46:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:16 INFO - 'PWD': '/builds/slave/test', 18:46:16 INFO - 'SHELL': '/bin/bash', 18:46:16 INFO - 'SHLVL': '1', 18:46:16 INFO - 'TERM': 'linux', 18:46:16 INFO - 'TMOUT': '86400', 18:46:16 INFO - 'USER': 'cltbld', 18:46:16 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060', 18:46:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:16 INFO - '_': '/tools/buildbot/bin/python'} 18:46:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:46:16 INFO - Cleaning up... 18:46:16 INFO - Return code: 0 18:46:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:46:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x16171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19877a0>, '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 0x19886a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1988b30>, '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': '62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060', '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 18:46:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:46:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:46:16 INFO - Using env: {'DISPLAY': ':0', 18:46:16 INFO - 'HOME': '/home/cltbld', 18:46:16 INFO - 'LANG': 'en_US.UTF-8', 18:46:16 INFO - 'LANGUAGE': 'en_US:en', 18:46:16 INFO - 'LOGNAME': 'cltbld', 18:46:16 INFO - 'MAIL': '/var/mail/cltbld', 18:46:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:16 INFO - 'MOZ_NO_REMOTE': '1', 18:46:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:16 INFO - 'NO_EM_RESTART': '1', 18:46:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:16 INFO - 'PWD': '/builds/slave/test', 18:46:16 INFO - 'SHELL': '/bin/bash', 18:46:16 INFO - 'SHLVL': '1', 18:46:16 INFO - 'TERM': 'linux', 18:46:16 INFO - 'TMOUT': '86400', 18:46:16 INFO - 'USER': 'cltbld', 18:46:16 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060', 18:46:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:16 INFO - '_': '/tools/buildbot/bin/python'} 18:46:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:16 INFO - Downloading/unpacking blobuploader==1.2.4 18:46:16 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 18:46:16 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 18:46:16 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 18:46:16 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 18:46:17 INFO - Downloading blobuploader-1.2.4.tar.gz 18:46:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:46:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:46:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:46:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:18 INFO - Downloading docopt-0.6.1.tar.gz 18:46:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:46:18 INFO - Installing collected packages: blobuploader, requests, docopt 18:46:18 INFO - Running setup.py install for blobuploader 18:46:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:46:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:46:18 INFO - Running setup.py install for requests 18:46:18 INFO - Running setup.py install for docopt 18:46:18 INFO - Successfully installed blobuploader requests docopt 18:46:18 INFO - Cleaning up... 18:46:18 INFO - Return code: 0 18:46:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:46:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:18 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 0x16171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19877a0>, '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 0x19886a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1988b30>, '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': '62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060', '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 18:46:18 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 18:46:18 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 18:46:18 INFO - Using env: {'DISPLAY': ':0', 18:46:18 INFO - 'HOME': '/home/cltbld', 18:46:18 INFO - 'LANG': 'en_US.UTF-8', 18:46:18 INFO - 'LANGUAGE': 'en_US:en', 18:46:18 INFO - 'LOGNAME': 'cltbld', 18:46:18 INFO - 'MAIL': '/var/mail/cltbld', 18:46:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:18 INFO - 'MOZ_NO_REMOTE': '1', 18:46:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:18 INFO - 'NO_EM_RESTART': '1', 18:46:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:18 INFO - 'PWD': '/builds/slave/test', 18:46:18 INFO - 'SHELL': '/bin/bash', 18:46:18 INFO - 'SHLVL': '1', 18:46:18 INFO - 'TERM': 'linux', 18:46:18 INFO - 'TMOUT': '86400', 18:46:18 INFO - 'USER': 'cltbld', 18:46:18 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060', 18:46:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:18 INFO - '_': '/tools/buildbot/bin/python'} 18:46:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:46:19 INFO - Running setup.py (path:/tmp/pip-OeYvCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:46:19 INFO - Running setup.py (path:/tmp/pip-nJ8YV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:46:19 INFO - Running setup.py (path:/tmp/pip-16Odus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:46:19 INFO - Running setup.py (path:/tmp/pip-RpZ6C0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:46:19 INFO - Running setup.py (path:/tmp/pip-h06zSV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:46:19 INFO - Running setup.py (path:/tmp/pip-HeaepF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:46:19 INFO - Running setup.py (path:/tmp/pip-7cHeaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:46:19 INFO - Running setup.py (path:/tmp/pip-8F8XbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:46:19 INFO - Running setup.py (path:/tmp/pip-2lrXFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:46:19 INFO - Running setup.py (path:/tmp/pip-o4v5ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:46:19 INFO - Running setup.py (path:/tmp/pip-3ZdKFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:46:19 INFO - Running setup.py (path:/tmp/pip-7EueNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:46:19 INFO - Running setup.py (path:/tmp/pip-eozxH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:46:20 INFO - Running setup.py (path:/tmp/pip-OclE71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:46:20 INFO - Running setup.py (path:/tmp/pip-pch5pa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:46:20 INFO - Running setup.py (path:/tmp/pip-tMfAHK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:46:20 INFO - Running setup.py (path:/tmp/pip-I3oBg9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:46:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:46:20 INFO - Running setup.py install for manifestparser 18:46:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:46:20 INFO - Running setup.py install for mozcrash 18:46:20 INFO - Running setup.py install for mozdebug 18:46:20 INFO - Running setup.py install for mozdevice 18:46:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:46:20 INFO - Running setup.py install for mozfile 18:46:20 INFO - Running setup.py install for mozhttpd 18:46:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:46:20 INFO - Running setup.py install for mozinfo 18:46:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:46:21 INFO - Running setup.py install for mozInstall 18:46:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:46:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:46:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:46:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:46:21 INFO - Running setup.py install for mozleak 18:46:21 INFO - Running setup.py install for mozlog 18:46:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:46:21 INFO - Running setup.py install for moznetwork 18:46:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:46:21 INFO - Running setup.py install for mozprocess 18:46:21 INFO - Running setup.py install for mozprofile 18:46:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:46:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:46:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:46:21 INFO - Running setup.py install for mozrunner 18:46:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:46:21 INFO - Running setup.py install for mozscreenshot 18:46:21 INFO - Running setup.py install for moztest 18:46:22 INFO - Running setup.py install for mozversion 18:46:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:46:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:46:22 INFO - Cleaning up... 18:46:22 INFO - Return code: 0 18:46:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:46:22 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')]} 18:46:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:22 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')]} 18:46:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:22 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 0x16171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19877a0>, '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 0x19886a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1988b30>, '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': '62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060', '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 18:46:22 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 18:46:22 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 18:46:22 INFO - Using env: {'DISPLAY': ':0', 18:46:22 INFO - 'HOME': '/home/cltbld', 18:46:22 INFO - 'LANG': 'en_US.UTF-8', 18:46:22 INFO - 'LANGUAGE': 'en_US:en', 18:46:22 INFO - 'LOGNAME': 'cltbld', 18:46:22 INFO - 'MAIL': '/var/mail/cltbld', 18:46:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:22 INFO - 'MOZ_NO_REMOTE': '1', 18:46:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:22 INFO - 'NO_EM_RESTART': '1', 18:46:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:22 INFO - 'PWD': '/builds/slave/test', 18:46:22 INFO - 'SHELL': '/bin/bash', 18:46:22 INFO - 'SHLVL': '1', 18:46:22 INFO - 'TERM': 'linux', 18:46:22 INFO - 'TMOUT': '86400', 18:46:22 INFO - 'USER': 'cltbld', 18:46:22 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060', 18:46:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:22 INFO - '_': '/tools/buildbot/bin/python'} 18:46:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:46:22 INFO - Running setup.py (path:/tmp/pip-928S_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:46:22 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)) 18:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:46:22 INFO - Running setup.py (path:/tmp/pip-ZKp9eg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:46:22 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)) 18:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:46:22 INFO - Running setup.py (path:/tmp/pip-HvP1KP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:46:22 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)) 18:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:46:22 INFO - Running setup.py (path:/tmp/pip-BL623d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:46:22 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)) 18:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:46:22 INFO - Running setup.py (path:/tmp/pip-t0lIik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:46:22 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)) 18:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:46:22 INFO - Running setup.py (path:/tmp/pip-MJd1X3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:46:22 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)) 18:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:46:22 INFO - Running setup.py (path:/tmp/pip-17N2EV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:46:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 18:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:46:22 INFO - Running setup.py (path:/tmp/pip-Oj3kxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:46:22 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)) 18:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:46:22 INFO - Running setup.py (path:/tmp/pip-CuPZiE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:46:22 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)) 18:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:46:22 INFO - Running setup.py (path:/tmp/pip-fEtm0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:46:23 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)) 18:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:46:23 INFO - Running setup.py (path:/tmp/pip-8OZZT6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:46:23 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)) 18:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:46:23 INFO - Running setup.py (path:/tmp/pip-8nsPqo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:46:23 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)) 18:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:46:23 INFO - Running setup.py (path:/tmp/pip-AIUkNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:46:23 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)) 18:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:46:23 INFO - Running setup.py (path:/tmp/pip-FD6mO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:46:23 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)) 18:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:46:23 INFO - Running setup.py (path:/tmp/pip-vp_C0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:46:23 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)) 18:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:46:23 INFO - Running setup.py (path:/tmp/pip-oXOkLZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:46:23 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)) 18:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:46:23 INFO - Running setup.py (path:/tmp/pip-wV_U3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:46:23 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)) 18:46:23 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)) 18:46:23 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)) 18:46:23 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)) 18:46:23 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)) 18:46:23 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)) 18:46:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:46:23 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 18:46:23 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 18:46:23 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 18:46:23 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 18:46:24 INFO - Downloading blessings-1.6.tar.gz 18:46:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:46:24 INFO - Installing collected packages: blessings 18:46:24 INFO - Running setup.py install for blessings 18:46:24 INFO - Successfully installed blessings 18:46:24 INFO - Cleaning up... 18:46:24 INFO - Return code: 0 18:46:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:46:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:46:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:46:25 INFO - Reading from file tmpfile_stdout 18:46:25 INFO - Current package versions: 18:46:25 INFO - argparse == 1.2.1 18:46:25 INFO - blessings == 1.6 18:46:25 INFO - blobuploader == 1.2.4 18:46:25 INFO - docopt == 0.6.1 18:46:25 INFO - functools32 == 3.2.3-2 18:46:25 INFO - jsonschema == 2.5.1 18:46:25 INFO - manifestparser == 1.1 18:46:25 INFO - mozInstall == 1.12 18:46:25 INFO - mozcrash == 1.0 18:46:25 INFO - mozdebug == 0.1 18:46:25 INFO - mozdevice == 0.51 18:46:25 INFO - mozfile == 1.2 18:46:25 INFO - mozhttpd == 0.7 18:46:25 INFO - mozinfo == 0.9 18:46:25 INFO - mozleak == 0.1 18:46:25 INFO - mozlog == 3.4 18:46:25 INFO - moznetwork == 0.27 18:46:25 INFO - mozprocess == 0.25 18:46:25 INFO - mozprofile == 0.28 18:46:25 INFO - mozrunner == 6.13 18:46:25 INFO - mozscreenshot == 0.1 18:46:25 INFO - mozsystemmonitor == 0.3 18:46:25 INFO - moztest == 0.8 18:46:25 INFO - mozversion == 1.4 18:46:25 INFO - psutil == 3.1.1 18:46:25 INFO - requests == 1.2.3 18:46:25 INFO - wsgiref == 0.1.2 18:46:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:46:25 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')]} 18:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:25 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')]} 18:46:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:25 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 0x16171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19877a0>, '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 0x19886a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1988b30>, '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': '62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060', '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 18:46:25 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 18:46:25 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 18:46:25 INFO - Using env: {'DISPLAY': ':0', 18:46:25 INFO - 'HOME': '/home/cltbld', 18:46:25 INFO - 'LANG': 'en_US.UTF-8', 18:46:25 INFO - 'LANGUAGE': 'en_US:en', 18:46:25 INFO - 'LOGNAME': 'cltbld', 18:46:25 INFO - 'MAIL': '/var/mail/cltbld', 18:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:25 INFO - 'MOZ_NO_REMOTE': '1', 18:46:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:25 INFO - 'NO_EM_RESTART': '1', 18:46:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:25 INFO - 'PWD': '/builds/slave/test', 18:46:25 INFO - 'SHELL': '/bin/bash', 18:46:25 INFO - 'SHLVL': '1', 18:46:25 INFO - 'TERM': 'linux', 18:46:25 INFO - 'TMOUT': '86400', 18:46:25 INFO - 'USER': 'cltbld', 18:46:25 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060', 18:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:25 INFO - '_': '/tools/buildbot/bin/python'} 18:46:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:25 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)) 18:46:25 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)) 18:46:25 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)) 18:46:25 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)) 18:46:25 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)) 18:46:25 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)) 18:46:25 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)) 18:46:25 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)) 18:46:25 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)) 18:46:25 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 18:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:46:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:46:26 INFO - Downloading marionette_driver-1.4.0.tar.gz 18:46:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 18:46:26 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)) 18:46:26 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)) 18:46:26 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)) 18:46:26 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)) 18:46:26 INFO - Installing collected packages: marionette-driver 18:46:26 INFO - Running setup.py install for marionette-driver 18:46:26 INFO - Successfully installed marionette-driver 18:46:26 INFO - Cleaning up... 18:46:26 INFO - Return code: 0 18:46:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:46:26 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')]} 18:46:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:46:26 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')]} 18:46:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:46:26 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 0x16171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x198a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19877a0>, '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 0x19886a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1988b30>, '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': '62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060', '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 18:46:26 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 18:46:26 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 18:46:26 INFO - Using env: {'DISPLAY': ':0', 18:46:26 INFO - 'HOME': '/home/cltbld', 18:46:26 INFO - 'LANG': 'en_US.UTF-8', 18:46:26 INFO - 'LANGUAGE': 'en_US:en', 18:46:26 INFO - 'LOGNAME': 'cltbld', 18:46:26 INFO - 'MAIL': '/var/mail/cltbld', 18:46:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:26 INFO - 'MOZ_NO_REMOTE': '1', 18:46:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:26 INFO - 'NO_EM_RESTART': '1', 18:46:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:26 INFO - 'PWD': '/builds/slave/test', 18:46:26 INFO - 'SHELL': '/bin/bash', 18:46:26 INFO - 'SHLVL': '1', 18:46:26 INFO - 'TERM': 'linux', 18:46:26 INFO - 'TMOUT': '86400', 18:46:26 INFO - 'USER': 'cltbld', 18:46:26 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060', 18:46:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:26 INFO - '_': '/tools/buildbot/bin/python'} 18:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:46:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:46:26 INFO - Cleaning up... 18:46:26 INFO - Return code: 0 18:46:26 INFO - Running post-action listener: _resource_record_post_action 18:46:26 INFO - Running post-action listener: _start_resource_monitoring 18:46:26 INFO - Starting resource monitoring. 18:46:26 INFO - [mozharness: 2017-05-25 01:46:26.898300Z] Finished create-virtualenv step (success) 18:46:26 INFO - [mozharness: 2017-05-25 01:46:26.898807Z] Running install step. 18:46:26 INFO - Running pre-action listener: _resource_record_pre_action 18:46:26 INFO - Running main action method: install 18:46:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:46:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:46:27 INFO - Reading from file tmpfile_stdout 18:46:27 INFO - Detecting whether we're running mozinstall >=1.0... 18:46:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:46:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:46:27 INFO - Reading from file tmpfile_stdout 18:46:27 INFO - Output received: 18:46:27 INFO - Usage: mozinstall [options] installer 18:46:27 INFO - Options: 18:46:27 INFO - -h, --help show this help message and exit 18:46:27 INFO - -d DEST, --destination=DEST 18:46:27 INFO - Directory to install application into. [default: 18:46:27 INFO - "/builds/slave/test"] 18:46:27 INFO - --app=APP Application being installed. [default: firefox] 18:46:27 INFO - mkdir: /builds/slave/test/build/application 18:46:27 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'] 18:46:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 18:46:43 INFO - Reading from file tmpfile_stdout 18:46:43 INFO - Output received: 18:46:43 INFO - /builds/slave/test/build/application/firefox/firefox 18:46:43 INFO - Running post-action listener: _resource_record_post_action 18:46:43 INFO - [mozharness: 2017-05-25 01:46:43.149360Z] Finished install step (success) 18:46:43 INFO - [mozharness: 2017-05-25 01:46:43.149638Z] Running run-tests step. 18:46:43 INFO - Running pre-action listener: _resource_record_pre_action 18:46:43 INFO - Running main action method: run_tests 18:46:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:46:43 INFO - Python 2.7.3 18:46:43 INFO - Return code: 0 18:46:43 INFO - grabbing minidump binary from tooltool 18:46: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')]} 18:46:43 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 0x19877a0>, '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 0x19886a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1988b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:46:43 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 18:46:43 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 18:46:43 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 18:46:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:46:43 INFO - Return code: 0 18:46:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:46:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:46:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:46:43 INFO - ENV: RUST_BACKTRACE is now 1 18:46:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:46:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:46:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 18:46:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-018 --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 18:46:43 INFO - Using env: {'DISPLAY': ':0', 18:46:43 INFO - 'HOME': '/home/cltbld', 18:46:43 INFO - 'LANG': 'en_US.UTF-8', 18:46:43 INFO - 'LANGUAGE': 'en_US:en', 18:46:43 INFO - 'LOGNAME': 'cltbld', 18:46:43 INFO - 'MAIL': '/var/mail/cltbld', 18:46:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:46:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:46:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:46:43 INFO - 'MOZ_NO_REMOTE': '1', 18:46:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:46:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:46:43 INFO - 'NO_EM_RESTART': '1', 18:46:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:46:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:46:43 INFO - 'PWD': '/builds/slave/test', 18:46:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:46:43 INFO - 'RUST_BACKTRACE': '1', 18:46:43 INFO - 'SHELL': '/bin/bash', 18:46:43 INFO - 'SHLVL': '1', 18:46:43 INFO - 'TERM': 'linux', 18:46:43 INFO - 'TMOUT': '86400', 18:46:43 INFO - 'USER': 'cltbld', 18:46:43 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060', 18:46:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:46:43 INFO - '_': '/tools/buildbot/bin/python'} 18:46:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--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 18:46:43 INFO - mozversion application_buildid: 20170525004530 18:46:43 INFO - mozversion application_changeset: f81bcc23d37d7bec48f08b19a9327e93c54d37b5 18:46:43 INFO - mozversion application_display_name: Nightly 18:46:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:46:43 INFO - mozversion application_name: Firefox 18:46:43 INFO - mozversion application_remotingname: firefox 18:46:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:46:43 INFO - mozversion application_vendor: Mozilla 18:46:43 INFO - mozversion application_version: 55.0a1 18:46:43 INFO - mozversion platform_buildid: 20170525004530 18:46:43 INFO - mozversion platform_changeset: f81bcc23d37d7bec48f08b19a9327e93c54d37b5 18:46:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:46:43 INFO - mozversion platform_version: 55.0a1 18:46:43 INFO - using testdate: 1495676803 18:46:43 INFO - actual date: 1495676803 18:46:43 INFO - starting webserver on 'localhost:53835' 18:46:43 INFO - SUITE-START | Running 2 tests 18:46:43 INFO - TEST-START | dromaeo_css 18:46:43 INFO - operating with platform_type : linux_ 18:46:43 INFO - Initialising browser for dromaeo_css test... 18:46:43 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53835/getInfo.html -profile /tmp/tmpnbWaKM/profile 18:46:43 INFO - TEST-INFO | started process 4895 (/builds/slave/test/build/application/firefox/firefox http://localhost:53835/getInfo.html) 18:47:18 INFO - TEST-INFO | 4895: killed by SIGTERM 18:47:18 INFO - Browser initialized. 18:47:18 INFO - Running cycle 1/1 for dromaeo_css test... 18:47:18 INFO - TEST-INFO | started process 5116 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnbWaKM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:47:30 INFO - PID 5116 | RSS: Main: 176189440 18:47:30 INFO - PID 5116 | 18:50:34 INFO - PID 5116 | Cycle 1(1): loaded http://localhost:53835/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53835/tests/dromaeo/cssquery-ext.html) 18:50:36 INFO - PID 5116 | RSS: Main: 173162496 18:50:36 INFO - PID 5116 | 18:53:38 INFO - PID 5116 | Cycle 1(1): loaded http://localhost:53835/tests/dromaeo/cssquery-ext.html (next: http://localhost:53835/tests/dromaeo/cssquery-jquery.html) 18:53:39 INFO - PID 5116 | RSS: Main: 180183040 18:53:39 INFO - PID 5116 | 18:56:40 INFO - PID 5116 | Cycle 1(1): loaded http://localhost:53835/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53835/tests/dromaeo/cssquery-mootools.html) 18:56:41 INFO - PID 5116 | RSS: Main: 178380800 18:56:41 INFO - PID 5116 | 18:59:43 INFO - PID 5116 | Cycle 1(1): loaded http://localhost:53835/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53835/tests/dromaeo/cssquery-prototype.html) 18:59:43 INFO - PID 5116 | RSS: Main: 181174272 18:59:43 INFO - PID 5116 | 19:02:46 INFO - PID 5116 | Cycle 1(1): loaded http://localhost:53835/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53835/tests/dromaeo/cssquery-yui.html) 19:02:47 INFO - PID 5116 | RSS: Main: 180461568 19:02:47 INFO - PID 5116 | 19:05:48 INFO - PID 5116 | Cycle 1(1): loaded http://localhost:53835/tests/dromaeo/cssquery-yui.html (next: http://localhost:53835/tests/dromaeo/cssquery-dojo.html) 19:05:49 INFO - PID 5116 | RSS: Main: 178438144 19:05:49 INFO - PID 5116 | 19:05:49 INFO - PID 5116 | __start_tp_report 19:05:49 INFO - PID 5116 | _x_x_mozilla_page_load 19:05:49 INFO - PID 5116 | _x_x_mozilla_page_load_details 19:05:49 INFO - PID 5116 | |i|pagename|runs| 19:05:49 INFO - PID 5116 | |0;dojo.html;2719.9456010879785;2732.740389662981;2754.187514683168;2774.30642339415;2777.652793400825;5193.45468725784;5246.081935661263;5273.8945221095555;5274.077036518613;5331.333583302083;5166.767495462704;5231.424543300234;5262.131748261532;5313.20301954707;5330.706811125387;4696.788644510988;4697.765111744417;4702.553257440555;4733.5739783419485;4774.68964517307;4694.671373003891;4736.526347365253;4768.570828625423;4779.450363208223;4817.614590832725;4647.9535204647855;4670.206064968964;4703.623710103184;4710.599599034086;4738.147133515966;4673.532646735333;4702.247640377524;4710.693804902705;4745.976270118627;4749.097671442415;4670.182718024332;4687.156311863863;4687.9531204687855;4704.553067458586;4750.097481478508;5096.923546146811;5242.056429842627;5259.605529585297;5292.629515933886;5337.839864804062;5700.7149642518125;5703.258576385043;5711.9718450678865;5722.2561067061015;5755.223044888929;5762.567807414461;5764;5765.1928729977835;5775.48020678141;5824.242848429677;5316.388615309212;5328.6802791832615;5331.333583302087;5332.786688532416;5333.466653334635;5708.914366284509;5781.161731548986;5798.710064496759;5855.092460668603;5864.120381942743;5538.363088244822;5539.612227144142;5547.694876781816;5590.552755779528;5601.439856014366;5717.371089180187;5736.62711923732;5737.913931291034;5740.54075673945;5753.424657534213;5576.414476479992;5598.104303311532;5722.656640601577;5723.627964182315;5730.684812335361;5595.860103497445;5614.410486898817;5637.379888212294;5688.715564221772;5699.059655156935;4698.671093023456;4701.388819453449;4704.15325241453;4704.5765881070865;4739.502352253033;4041.1109555897656;4045.3527435610163;4048.554658987509;4081.224567332257;4113.362428823537;4719.811207551659;4748.264019077049;4819.060283244734;4844.757762111951;4895.730734809548;5758.280214973129;5791.276090488689;5806.361300256968;5825.912611310834;5841.153032810219;4872.366592342973;4874.902501949941;4879.121758083508;4884.1941079722155;4913.877153071202;4886.535779101051;5033.79864805411;5039.21892106724;5050.520200580939;5054.848354549369;5340.412554618911;5353;5371.758270877742;5436.537894278872;5468.644538105011;5615.8876822464135;5705.885882282414;5767.9134812977;5800.1589769484035;5821;5333.7866485340155;5338.492843179892;5383.327084114486;5384.19237114436;5427.158790387496;5623.662580245198;5654.491095801398;5657.886842263049;5671.8865622688145;5672.290963629546;5593.440655934374;5687.829365119053;5756.107803290497;5784.623999440023;5786.942130578809;5475.589330800126;5520.585956053232;5540.390557038642;5542.002439560918;5570.387257401763;5513.558915286848;5543.307086614173;5557.138643510262;5567.860803479945;5574.219609254626;5417.837464875903;5462.153366228241;5467.644603100785;5469.425710300361;5509.944900551103;5488.313960754906;5541.944580554304;5574.717814902676;5596.552275818006;5619.8595035124445;5416.891662166656;5438.755256013568;5446.264754258124;5448.237246785532;5507.421720719267 19:05:49 INFO - PID 5116 | |1;ext.html;628.8019273928712;678.7963610916726;699.2308460693237;1123.8258069999147;1184.2480025184016;33331.83334083329;34923.126921826966;34928.476072858895;35009;35035.47446788294;33198.66801331986;33400.49899251513;33532.32935341292;33582.83208583954;33594;6277.058441233818;6426.903596446057;6529.2817790043055;6744.966275168642;6746.527743057988;6800.183977922657;6838.897416538756;6919.342662447085;6939.23668396476;6939.618320992344;6909.758158464455;6932.306769323078;6942.375186233238;6952.965235173817;6982.825429364256;6910;6924.792256232321;6937.583744975267;6938.09804725385;6941.930580694229;6681.76613818514;6727.058211850345;6727.461803055744;6728.899066514006;6733.293004234534;31256.687433125604;31494.842525787226;31541.684583154332;31542.369152617048;31575.052748417584;3037.711417415342;3078.291992841637;3078.3227689908185;3082.321889184376;3086.753059755214;24587.508249834904;24634.630480542804;24667.753322466724;24691.38271543208;24751.133710320053;2958.685913389746;2973.4945059339966;2988.970110298891;3020.7130322619314;3075.3388021575247;138930;139663.30168349194;139680;145996;146964;39794.20411591752;39815.60184398119;40069.39895901564;40108.98365245236;40161.39757903634;40907.386389204185;41017.79491102525;41045.1790964179;41196.79401602973;43105.784471077444;13019.088663793444;13084.869151308556;13136.60590182277;13167.67080822968;13191.40638671243;10422.791544169075;10510.684679459475;10530.57877684884;10537.89462105369;10548.894511054945;12749.42627581761;12754.298513581842;12795.360231988363;12834;12880.935595321964;5358.544523715528;5373.435789242151;5462.934727728134;5469.425710300441;5486.423925487846;832.6003518311123;893.3746377535621;905.7961958559272;909.8498747706686;917.3165991336497;20077.598448030956;21002.264920727703;21005.579888402146;21149.365519034454;21321.629066041423;968.5689868008668;969.762408209979;983.955721992512;990.8266053440619;993.1707024634511;10403.947980260202;11059.778804423866;11107.777844443066;11146.331220126818;11321;170478;170790;171210;171301;171310;40376.39435408471;40651.59348406537;40714;40755.7962210193;40835.591644083775;1207.1851500237306;1226.576830993306;1241.267652085274;1245.5640525816073;1255.6735248835369;19240.615187696447;19913.900430498335;20564.794352056888;20600.38198854037;20858.165673373504;28855.711442886142;36407.817960910026;37570.81214594019;37596;37735.433968489946;161225;161464;162550.18724906773;162628.18685906968;162741;30087.69912300849;30181.849090755284;30254.697453025186;30388.544171837;30596;34654.82672586621;35265.29469410649;35715.46426803548;35742.64257357497;35883.82058089693;26473.205803825917;26815.731842682104;26976;27478.0382686605;27712.58431123575;23461.648075278543;24081.277561673178;24113.879430602734;24199.75800241975;24616.753832462164;29367.559486608145;29494.557581636724;29740;29839.701602983692;29993.250168745082;25945.610815838154;26182.34544136412;26551.33621659474;26976.865115675082;27458.17625471239;19733.506662332984;20394.490137746674;20450.48873778108;20485.897570512054;20489.897550512153 19:05:49 INFO - PID 5116 | |2;jquery.html;398.66113803267206;401.752921952999;410.29224587586407;422.35590724145686;435.2600579015672;17009.829901700978;17444.56388590286;17908.104594770273;17911.462656120322;18044.63910721785;16665.083420411902;16832;16867;17813.554661133447;18861.717074243898;5444.482774136461;5603.80386686466;5634.746436410372;5648.124540696199;5653.886922261552;5254.448282930294;5393.460653934614;5407.864803379927;5442.510174084332;5454.481824226692;5396.43337449568;5409.188621706736;5412.052890744104;5412.783488660449;5443.1835224716215;5314.149736042234;5414.512693857552;5506.944930550703;5518.172274158868;5532.336119665666;4971.304017437562;4984.053029924303;5002;5002.974985125051;5014.122528557525;21111;21176.470588235265;21612.675809862863;21654.89172554143;21671.566568668695;1607.7990251218598;1614.1848366574923;1619.983800161995;1619.9919000404923;1624.285314461645;13911.234882081482;13919;13962.790558141636;13985.79021314681;14308;2027.7262569553216;2040.5000774810119;2060.5878824235065;2095.9266425675182;2102.9474263143543;83871;84458.57770711106;84834.57582712047;85028;85409;11043.171762117712;11145.275557088764;11153.832692509619;11179.83230251547;11396.373199474108;15477.22613869302;15625.218739063;15641.452549160726;15669.216539172996;15707.214639267992;7676.424268179909;7759.534427934229;7911.349697851169;7923.603819808986;7972.521648701097;7240.855182896313;7276.818079548054;7292.525985811011;7457.105147382349;7499.812504687427;6839.093385311322;7026.332498412643;7037.753678621326;7046.582407532343;7073.540219885691;1933.3136736458355;1997.340877510418;2010.6380851446588;2011.8591698581251;2031.9288824891057;840.2311884625499;877.7586163804878;883.3463237204422;890.470170248701;901.1304091551684;15806.446774362843;15863.714953387436;16238.188090595422;16510.917445412935;16753.664926701396;864.4683519635505;878.0648609231276;881.4006475596527;885.5173930208052;904.0959040959041;8784.907620612636;8850.73447796567;8986.370954033286;9120.315976301805;9166.22087122602;348843.25578372454;354304.0265570785;360681;378121;383531;66976.95811065541;75245.6237718808;80354.19645803585;81433;84041.15958840333;1066.9466526673634;1075.4138994248153;1120.227043340109;1127.3179726265655;1129.7909886670993;16342.428015019417;16767.24547395346;17185.31258749636;17311.653766924843;17494.212760426068;38750.80624596859;39059.218815624095;39178.02054948649;39648.40527392149;39897;48925.2661210075;49341.2598811011;49540;50078.49921500738;50982;7582.317591416579;7649.923500765144;7681.964279466058;7751.844963100593;7757.185495523115;10963.725906852393;11040.116790656888;11304.773904521699;11575.479103440197;11632.54593175853;9656.71029869105;9823.459709716035;9826.361286516354;10147.79704405893;10381.896181038093;9551.952240238754;9587.760305992406;9635.5663995119;9666.468344241135;9736.561854716696;9742.464164471023;9925.751856203653;9927.702168934655;10228.07947284748;10462.581496740046;7972.760817175494;8112.594370281345;8405.285550728257;8473.364497662576;8479;10446.425446600206;10546.419946902994;10726.73183170427;10735.785284294427;10887.401192934465 19:05:49 INFO - PID 5116 | |3;mootools.html;1248.9375531223438;1292.2182079841696;1302.9283389413579;1304.3739005277464;1306.105317857268;10291.382517048982;10535.209859260547;10830.296030758005;10873.728156796074;10886.782264354708;10270.281080324361;10396;10422.843657345145;10430.269881108325;10447.477626118683;2201.1195521791333;2221.455743342883;2223.5775202711434;2237.2281562860785;2250.909963601454;2118.142152428269;2168.1219106261988;2168.360333701562;2174.7825217478285;2176.3906106290265;2091.393495886191;2154.202944910385;2162.4269568564264;2166.9024893879814;2171.5873983943;2074.9273775417864;2091.592139532792;2103.663413853776;2110.2508609443657;2118.6610142377144;1838.5219842840825;1912.0917564157053;1999.1803360622075;2049.1700861151107;2159.9784002159936;10728.517216725188;10765.677029689123;10831.620893268699;10865.945670271678;10883.129349652008;5454.772676147874;5703;5715.771369145229;5718.542516598662;5721;3171.1437911763924;3292.983535082333;3370.7303415726683;3371.7302615790677;3385.4752513360468;1066.2909165404997;1070.4219721350462;1075.5805235957982;1079.854219680341;1100.5267734874;15775;15940.920295398564;16009;16024;16056.518304450885;4488.753118578509;4616.799632095612;4765.499622539653;4775.6657034007285;4799.112164249625;11072.612458563912;11077.169212309109;11086.390248536409;11098.2786118902;11099.445027748741;5514.283143191359;5610.775568977195;5611.354694210218;5628.296462942132;5642.576806739511;5159.045576568272;5195.610329225247;5228.9477105229225;5246.501582349671;5257.2639830423;3683.2633473305445;3760.2667479841716;3779.5464544254864;3813.904652383713;3894.7078969077434;1021.1320377678913;1030.6804890483975;1039.365986748083;1052.3265110329241;1058.4178701714027;676.587281758137;685.2667645619239;690.0373978300344;705.1221229569219;706.2513735440347;5229.163333866563;5288.418273989858;5314.441983591667;5483.232347471358;5499.202615620713;504.20335869326374;529.9867503312448;534.7219445888194;535.4056996733623;537.4249552978354;3244.9837750811093;3337.3158502506926;3424.072418082553;3433.4163192257374;3589.174489867345;13303;13900.374483148282;14246.572602821932;14286.499972500913;14301;13861.86138138626;13924.164550127025;13953.511627093003;14064.648383790487;14137.293135343192;7219.628270628564;7479.214682458372;7508;7586.431017673696;7597.088349398107;5374.167004114369;5403.270558474555;5405.108157154025;5502.972485137709;5622.156676498558;12387.938060309642;12450.25298482094;12501.124921255425;12610.49558017669;12783.041271904458;12541.369621949088;13006;13095.017873659704;13171.802422963472;13183.209007459584;8546.059933407196;8624.137586241326;8659.567021648767;8732.388732788899;8732.78168045804;9516.286278529;9552.092551207625;9556.904430955601;9576.904230957602;9585.185259253041;8527.06202317757;8562.143785621638;8566.657333706582;8694.608742606724;8739.694110706096;8359.95820020896;8432.494050356998;8443.915560844558;8606.440581362442;8656.610452529778;7415.592142432002;7548.433867460072;7549.245075492407;7563.886541701769;7578.621068946641;4346.847860325;4961.627877909099;5043.697378157322;5062.139436295912;5090.821821236239;4999.275105109666;5159.922601161061;5238.68567885928;5240.2663627093;5301.761420736153 19:05:49 INFO - PID 5116 | |4;prototype.html;346.9705075068619;366.6242101845608;368.10366756946826;376.3940056509018;376.41279603818043;5418.566514678826;5564.221009058725;5570.387257401688;5604.943950560493;5638.407967163445;5358.705271210082;5402.837914862561;5409.918851217235;5419.349678038631;5425.294711687485;4060.553339132693;4061.6750659947133;4069.9999999999927;4074.9592504074876;4093.7953102344763;3940.5074365704286;4072.328065869143;4080.469538959931;4089.5092588889374;4089.652379547742;4024.517057953035;4057.127717540728;4068.125353049094;4069.726786873771;4095.221907837516;4048.1903619276263;4048.3725022621543;4055.8377664893665;4056.472658554384;4059.2084543514025;3500.789952602852;3518.9296214075575;3521.1725244567506;3521.9823900880588;3524;5239.318888544465;5326.92009619856;5340.67955922642;5358.705271210082;5359.196120581905;4742.857714268577;4748.881277968044;4753.595944344735;4776.832810851638;4797.040591881638;5604.8038318658655;5721.828345149652;5748.367679555246;5752.194692743019;5773.2494775679315;3925.3130702127014;3939.212157568469;3964.86122985697;3967.662748666367;3968.464257325282;5880.764769409218;6103.206583144207;6105.694715264263;6110.327863934964;6145.661988590626;4026.1545075534464;4033.4353190553347;4034.8184331705143;4060.553339132693;4062.857799976987;4111.342185250405;4111.506619205715;4116.485439320085;4118.155778065549;4123.958760412357;4699.295105734167;4747.287906813936;4767.928481072787;4776.546228108394;4783.145107715672;5777.913331300034;5784.739686714108;5786.846168837993;5796.710164491843;5826.650400975955;1395.6929475515371;1398.7132637809225;1399.293356854782;1401.10329389191;1403.6982048859545;893.6693423433371;933.7152168588646;948.137195152408;957.8323793336139;958.2765012415582;5009.123403404463;5022.447530771612;5024.57291130258;5026.89946201074;5031.496850314939;5933.584649074523;5948.512871782054;5970;5989.401059894063;5997.820065398045;4867.756612169448;5002.649814513022;5006.89986200274;5027.195648696191;5031.823886163967;3159.988803582831;3166.398384306974;3168.98415507921;3178.3631429813663;3181.3637272545584;5549.556035517149;5629.211910332557;5640.266765320482;5653.886922261532;5680.7727690892725;6096.237970253718;6116.174316467309;6129.295131059986;6133.447989680861;6157.384261573897;5604.271444712162;5610.551155907436;5645.153227015899;5658.094704847204;5658.886822263614;5867.354590995073;5963.671998039976;5964.433378829004;5964.880702385841;5993.31076926159;5881.264841894763;5909.6158749681135;5916.31962324321;5922;5931.584789064724;5457.536109430743;5586.441355864381;5627.352854421631;5629.718514074362;5653.297090405791;4031.2061132795625;4031.3146765049423;4035.1324465240114;4045.352743561134;4054.310767169647;5942.7920022799;6041.697915104315;6088.726007329592;6088.908666369919;6115.174451448997;5806.883862322646;5820.73806678692;5838.795642152674;5843.422275985545;5857.560682948711;5784.293633378079;5806.82579522615;5807.477327040587;5827.1841942127285;5850.444207800252;5557.3331200256225;5672.773089076556;5677.148427735872;5710.8572285691525;5717.17101020358;5830.53355731549;5849.239598852122;5849.766009359578;5857.824265272048;5865.736041878211;5602.561740230513;5634.661920284796;5634.74643641029;5651.717414129195;5686.180422265001 19:05:49 INFO - PID 5116 | |5;yui.html;716.8888822232556;728.4245446097583;755.5693254844738;759.4987308376473;774.9728759493419;13674;14304.427822887099;14467.565973020814;15049.54851354461;15599.376024959016;15981.440649577267;16039.198040098006;16051.598710032255;16153.111578863158;16174.110423926708;872.1191596487562;887.8535041718109;888.9377743557953;889.715291106846;894.9463032218088;903.530164314556;905.3255324783046;905.4748246017327;906.5286051253345;908.454927043775;886.0829041941591;900.8513595256808;906.9047749986255;909.3861643390718;910.1353713971753;905.0858632780872;905.3933864310927;906.714384968736;907.8865141857268;908.3823000359786;664.7673314339991;666.4601672645173;666.8266250774785;668.011343212044;668.6489592963733;14142.92928535361;14378.496752613608;14382.856171438256;14384.35270412834;14407.423703051865;15615.453459128876;15894.443694470638;16395.344186232538;16421.178941052898;16421.91789041059;12061.93969030158;12250.571230006906;12364.690882727913;12393.75212495754;12500.187487813353;3102.612173478315;3109.2226943264186;3118.1269244611544;3122.6252849658185;3126.234072652192;83113.16886831114;83553;84383.57808210919;84539;84975.99999999939;12241.265524068584;12316.938415307866;12339.814902776465;12386.876131238752;12404.379781010914;20253;20787.272445464638;20854.58290834175;20869.478263043242;21008.369748907557;5826.184334193216;5842.269716285465;5874.588778785529;5888.3228428731245;5898.557608179318;2829.858507074638;2848.430313937221;2867.526858068437;2880.625518682558;2894.3777087926196;3765.981170094187;3846.0961674006585;3871.7676939383164;3880.2433525462266;3885;666.0841343153164;673.9898901516481;676.1851968378093;676.2189670930084;677.075791544548;592.1916583862997;607.0782743477099;618.4712071179167;624.0452108274347;624.4785604020602;9544.284178686627;9938.850917236246;10018.198544116452;10406.323588966692;10867.076298514714;505.23709199108873;509.39636530711226;511.2535697881135;513.4095789841638;515.2220147577185;4350.6736994725525;4495.415595972503;4552.795124219418;4567.680262381601;4612.838550650711;81589.18410815934;81665.59167204244;82061;82796;82899.5855020721;76551;76674;76764.61617691988;76825.61587192028;77854;60280;61610.38389616136;61942.380576195465;62349.37650623436;63615.23955477525;10033.749156271151;10335.364482057028;10422.635207767691;10605.151587872797;11017.944910275397;28048;28130.578041329805;28410;28617.856910715313;29641.555376668937;35026.299474010884;35240.82379588085;35245.471317930766;35772.4634130483;36478.27043459169;14686.63283417923;14806.407743690132;14864.331105100513;14913.776293355391;15042.323095460511;15856.682866342839;16097.436589719304;16401;16687.08221047854;16712.41506547265;14824.555263342118;14897.553073407815;15177.317020733874;15216;15453.304601293194;12915;13064.54274100402;13210.801837972245;13218.20690758519;13272.535461258809;13746.793798092836;14359.497417590333;14549.92725036368;14699.706005879609;14759.335829887896;10895.673129806119;11213.55145794159;11321.320720756781;11389;11760.000399966098;11691.883081169079;12181.573644922386;12222.938885305517;12236.69408264765;12486.875131248935 19:05:49 INFO - PID 5116 | __end_tp_report 19:05:49 INFO - PID 5116 | __start_cc_report 19:05:49 INFO - PID 5116 | _x_x_mozilla_cycle_collect,344 19:05:49 INFO - PID 5116 | __end_cc_report 19:05:49 INFO - PID 5116 | __startTimestamp1495677949179__endTimestamp 19:05:49 INFO - PID 5116 | 19:05:49 INFO - PID 5116 | ------- Summary: start ------- 19:05:49 INFO - PID 5116 | Number of tests: 6 19:05:49 INFO - PID 5116 | 19:05:49 INFO - PID 5116 | [#0] dojo.html Cycles:165 Average:5214.89 Median:5416.89 stddev:618.94 (11.4%) stddev-sans-first:589.08 19:05:49 INFO - PID 5116 | Values: 2719.9 2732.7 2754.2 2774.3 2777.7 5193.5 5246.1 5273.9 5274.1 5331.3 5166.8 5231.4 5262.1 5313.2 5330.7 4696.8 4697.8 4702.6 4733.6 4774.7 4694.7 4736.5 4768.6 4779.5 4817.6 4648.0 4670.2 4703.6 4710.6 4738.1 4673.5 4702.2 4710.7 4746.0 4749.1 4670.2 4687.2 4688.0 4704.6 4750.1 5096.9 5242.1 5259.6 5292.6 5337.8 5700.7 5703.3 5712.0 5722.3 5755.2 5762.6 5764.0 5765.2 5775.5 5824.2 5316.4 5328.7 5331.3 5332.8 5333.5 5708.9 5781.2 5798.7 5855.1 5864.1 5538.4 5539.6 5547.7 5590.6 5601.4 5717.4 5736.6 5737.9 5740.5 5753.4 5576.4 5598.1 5722.7 5723.6 5730.7 5595.9 5614.4 5637.4 5688.7 5699.1 4698.7 4701.4 4704.2 4704.6 4739.5 4041.1 4045.4 4048.6 4081.2 4113.4 4719.8 4748.3 4819.1 4844.8 4895.7 5758.3 5791.3 5806.4 5825.9 5841.2 4872.4 4874.9 4879.1 4884.2 4913.9 4886.5 5033.8 5039.2 5050.5 5054.8 5340.4 5353.0 5371.8 5436.5 5468.6 5615.9 5705.9 5767.9 5800.2 5821.0 5333.8 5338.5 5383.3 5384.2 5427.2 5623.7 5654.5 5657.9 5671.9 5672.3 5593.4 5687.8 5756.1 5784.6 5786.9 5475.6 5520.6 5540.4 5542.0 5570.4 5513.6 5543.3 5557.1 5567.9 5574.2 5417.8 5462.2 5467.6 5469.4 5509.9 5488.3 5541.9 5574.7 5596.6 5619.9 5416.9 5438.8 5446.3 5448.2 5507.4 19:05:49 INFO - PID 5116 | 19:05:49 INFO - PID 5116 | [#1] ext.html Cycles:180 Average:30251.08 Median:16713.13 stddev:41006.32 (245.4%) stddev-sans-first:41061.03 19:05:49 INFO - PID 5116 | Values: 628.8 678.8 699.2 1123.8 1184.2 33331.8 34923.1 34928.5 35009.0 35035.5 33198.7 33400.5 33532.3 33582.8 33594.0 6277.1 6426.9 6529.3 6745.0 6746.5 6800.2 6838.9 6919.3 6939.2 6939.6 6909.8 6932.3 6942.4 6953.0 6982.8 6910.0 6924.8 6937.6 6938.1 6941.9 6681.8 6727.1 6727.5 6728.9 6733.3 31256.7 31494.8 31541.7 31542.4 31575.1 3037.7 3078.3 3078.3 3082.3 3086.8 24587.5 24634.6 24667.8 24691.4 24751.1 2958.7 2973.5 2989.0 3020.7 3075.3 138930.0 139663.3 139680.0 145996.0 146964.0 39794.2 39815.6 40069.4 40109.0 40161.4 40907.4 41017.8 41045.2 41196.8 43105.8 13019.1 13084.9 13136.6 13167.7 13191.4 10422.8 10510.7 10530.6 10537.9 10548.9 12749.4 12754.3 12795.4 12834.0 12880.9 5358.5 5373.4 5462.9 5469.4 5486.4 832.6 893.4 905.8 909.8 917.3 20077.6 21002.3 21005.6 21149.4 21321.6 968.6 969.8 984.0 990.8 993.2 10403.9 11059.8 11107.8 11146.3 11321.0 170478.0 170790.0 171210.0 171301.0 171310.0 40376.4 40651.6 40714.0 40755.8 40835.6 1207.2 1226.6 1241.3 1245.6 1255.7 19240.6 19913.9 20564.8 20600.4 20858.2 28855.7 36407.8 37570.8 37596.0 37735.4 161225.0 161464.0 162550.2 162628.2 162741.0 30087.7 30181.8 30254.7 30388.5 30596.0 34654.8 35265.3 35715.5 35742.6 35883.8 26473.2 26815.7 26976.0 27478.0 27712.6 23461.6 24081.3 24113.9 24199.8 24616.8 29367.6 29494.6 29740.0 29839.7 29993.3 25945.6 26182.3 26551.3 26976.9 27458.2 19733.5 20394.5 20450.5 20485.9 20489.9 19:05:49 INFO - PID 5116 | 19:05:49 INFO - PID 5116 | [#2] jquery.html Cycles:180 Average:24491.95 Median:49440.63 stddev:60814.93 (123.0%) stddev-sans-first:60958.62 19:05:49 INFO - PID 5116 | Values: 398.7 401.8 410.3 422.4 435.3 17009.8 17444.6 17908.1 17911.5 18044.6 16665.1 16832.0 16867.0 17813.6 18861.7 5444.5 5603.8 5634.7 5648.1 5653.9 5254.4 5393.5 5407.9 5442.5 5454.5 5396.4 5409.2 5412.1 5412.8 5443.2 5314.1 5414.5 5506.9 5518.2 5532.3 4971.3 4984.1 5002.0 5003.0 5014.1 21111.0 21176.5 21612.7 21654.9 21671.6 1607.8 1614.2 1620.0 1620.0 1624.3 13911.2 13919.0 13962.8 13985.8 14308.0 2027.7 2040.5 2060.6 2095.9 2102.9 83871.0 84458.6 84834.6 85028.0 85409.0 11043.2 11145.3 11153.8 11179.8 11396.4 15477.2 15625.2 15641.5 15669.2 15707.2 7676.4 7759.5 7911.3 7923.6 7972.5 7240.9 7276.8 7292.5 7457.1 7499.8 6839.1 7026.3 7037.8 7046.6 7073.5 1933.3 1997.3 2010.6 2011.9 2031.9 840.2 877.8 883.3 890.5 901.1 15806.4 15863.7 16238.2 16510.9 16753.7 864.5 878.1 881.4 885.5 904.1 8784.9 8850.7 8986.4 9120.3 9166.2 348843.3 354304.0 360681.0 378121.0 383531.0 66977.0 75245.6 80354.2 81433.0 84041.2 1066.9 1075.4 1120.2 1127.3 1129.8 16342.4 16767.2 17185.3 17311.7 17494.2 38750.8 39059.2 39178.0 39648.4 39897.0 48925.3 49341.3 49540.0 50078.5 50982.0 7582.3 7649.9 7682.0 7751.8 7757.2 10963.7 11040.1 11304.8 11575.5 11632.5 9656.7 9823.5 9826.4 10147.8 10381.9 9552.0 9587.8 9635.6 9666.5 9736.6 9742.5 9925.8 9927.7 10228.1 10462.6 7972.8 8112.6 8405.3 8473.4 8479.0 10446.4 10546.4 10726.7 10735.8 10887.4 19:05:49 INFO - PID 5116 | 19:05:49 INFO - PID 5116 | [#3] mootools.html Cycles:180 Average:6407.77 Median:3378.60 stddev:4324.06 (128.0%) stddev-sans-first:4318.82 19:05:49 INFO - PID 5116 | Values: 1248.9 1292.2 1302.9 1304.4 1306.1 10291.4 10535.2 10830.3 10873.7 10886.8 10270.3 10396.0 10422.8 10430.3 10447.5 2201.1 2221.5 2223.6 2237.2 2250.9 2118.1 2168.1 2168.4 2174.8 2176.4 2091.4 2154.2 2162.4 2166.9 2171.6 2074.9 2091.6 2103.7 2110.3 2118.7 1838.5 1912.1 1999.2 2049.2 2160.0 10728.5 10765.7 10831.6 10865.9 10883.1 5454.8 5703.0 5715.8 5718.5 5721.0 3171.1 3293.0 3370.7 3371.7 3385.5 1066.3 1070.4 1075.6 1079.9 1100.5 15775.0 15940.9 16009.0 16024.0 16056.5 4488.8 4616.8 4765.5 4775.7 4799.1 11072.6 11077.2 11086.4 11098.3 11099.4 5514.3 5610.8 5611.4 5628.3 5642.6 5159.0 5195.6 5228.9 5246.5 5257.3 3683.3 3760.3 3779.5 3813.9 3894.7 1021.1 1030.7 1039.4 1052.3 1058.4 676.6 685.3 690.0 705.1 706.3 5229.2 5288.4 5314.4 5483.2 5499.2 504.2 530.0 534.7 535.4 537.4 3245.0 3337.3 3424.1 3433.4 3589.2 13303.0 13900.4 14246.6 14286.5 14301.0 13861.9 13924.2 13953.5 14064.6 14137.3 7219.6 7479.2 7508.0 7586.4 7597.1 5374.2 5403.3 5405.1 5503.0 5622.2 12387.9 12450.3 12501.1 12610.5 12783.0 12541.4 13006.0 13095.0 13171.8 13183.2 8546.1 8624.1 8659.6 8732.4 8732.8 9516.3 9552.1 9556.9 9576.9 9585.2 8527.1 8562.1 8566.7 8694.6 8739.7 8360.0 8432.5 8443.9 8606.4 8656.6 7415.6 7548.4 7549.2 7563.9 7578.6 4346.8 4961.6 5043.7 5062.1 5090.8 4999.3 5159.9 5238.7 5240.3 5301.8 19:05:49 INFO - PID 5116 | 19:05:49 INFO - PID 5116 | [#4] prototype.html Cycles:180 Average:4746.31 Median:5441.42 stddev:1433.65 (26.3%) stddev-sans-first:1399.13 19:05:49 INFO - PID 5116 | Values: 347.0 366.6 368.1 376.4 376.4 5418.6 5564.2 5570.4 5604.9 5638.4 5358.7 5402.8 5409.9 5419.3 5425.3 4060.6 4061.7 4070.0 4075.0 4093.8 3940.5 4072.3 4080.5 4089.5 4089.7 4024.5 4057.1 4068.1 4069.7 4095.2 4048.2 4048.4 4055.8 4056.5 4059.2 3500.8 3518.9 3521.2 3522.0 3524.0 5239.3 5326.9 5340.7 5358.7 5359.2 4742.9 4748.9 4753.6 4776.8 4797.0 5604.8 5721.8 5748.4 5752.2 5773.2 3925.3 3939.2 3964.9 3967.7 3968.5 5880.8 6103.2 6105.7 6110.3 6145.7 4026.2 4033.4 4034.8 4060.6 4062.9 4111.3 4111.5 4116.5 4118.2 4124.0 4699.3 4747.3 4767.9 4776.5 4783.1 5777.9 5784.7 5786.8 5796.7 5826.7 1395.7 1398.7 1399.3 1401.1 1403.7 893.7 933.7 948.1 957.8 958.3 5009.1 5022.4 5024.6 5026.9 5031.5 5933.6 5948.5 5970.0 5989.4 5997.8 4867.8 5002.6 5006.9 5027.2 5031.8 3160.0 3166.4 3169.0 3178.4 3181.4 5549.6 5629.2 5640.3 5653.9 5680.8 6096.2 6116.2 6129.3 6133.4 6157.4 5604.3 5610.6 5645.2 5658.1 5658.9 5867.4 5963.7 5964.4 5964.9 5993.3 5881.3 5909.6 5916.3 5922.0 5931.6 5457.5 5586.4 5627.4 5629.7 5653.3 4031.2 4031.3 4035.1 4045.4 4054.3 5942.8 6041.7 6088.7 6088.9 6115.2 5806.9 5820.7 5838.8 5843.4 5857.6 5784.3 5806.8 5807.5 5827.2 5850.4 5557.3 5672.8 5677.1 5710.9 5717.2 5830.5 5849.2 5849.8 5857.8 5865.7 5602.6 5634.7 5634.7 5651.7 5686.2 19:05:49 INFO - PID 5116 | 19:05:49 INFO - PID 5116 | [#5] yui.html Cycles:180 Average:17248.76 Median:3120.38 stddev:22619.14 (724.9%) stddev-sans-first:22648.52 19:05:49 INFO - PID 5116 | Values: 716.9 728.4 755.6 759.5 775.0 13674.0 14304.4 14467.6 15049.5 15599.4 15981.4 16039.2 16051.6 16153.1 16174.1 872.1 887.9 888.9 889.7 894.9 903.5 905.3 905.5 906.5 908.5 886.1 900.9 906.9 909.4 910.1 905.1 905.4 906.7 907.9 908.4 664.8 666.5 666.8 668.0 668.6 14142.9 14378.5 14382.9 14384.4 14407.4 15615.5 15894.4 16395.3 16421.2 16421.9 12061.9 12250.6 12364.7 12393.8 12500.2 3102.6 3109.2 3118.1 3122.6 3126.2 83113.2 83553.0 84383.6 84539.0 84976.0 12241.3 12316.9 12339.8 12386.9 12404.4 20253.0 20787.3 20854.6 20869.5 21008.4 5826.2 5842.3 5874.6 5888.3 5898.6 2829.9 2848.4 2867.5 2880.6 2894.4 3766.0 3846.1 3871.8 3880.2 3885.0 666.1 674.0 676.2 676.2 677.1 592.2 607.1 618.5 624.0 624.5 9544.3 9938.9 10018.2 10406.3 10867.1 505.2 509.4 511.3 513.4 515.2 4350.7 4495.4 4552.8 4567.7 4612.8 81589.2 81665.6 82061.0 82796.0 82899.6 76551.0 76674.0 76764.6 76825.6 77854.0 60280.0 61610.4 61942.4 62349.4 63615.2 10033.7 10335.4 10422.6 10605.2 11017.9 28048.0 28130.6 28410.0 28617.9 29641.6 35026.3 35240.8 35245.5 35772.5 36478.3 14686.6 14806.4 14864.3 14913.8 15042.3 15856.7 16097.4 16401.0 16687.1 16712.4 14824.6 14897.6 15177.3 15216.0 15453.3 12915.0 13064.5 13210.8 13218.2 13272.5 13746.8 14359.5 14549.9 14699.7 14759.3 10895.7 11213.6 11321.3 11389.0 11760.0 11691.9 12181.6 12222.9 12236.7 12486.9 19:05:49 INFO - PID 5116 | -------- Summary: end -------- 19:05:49 INFO - PID 5116 | 19:05:49 INFO - TEST-INFO | 5116: exit 0 19:05:49 INFO - TEST-OK | dromaeo_css | took 1146430ms 19:05:49 INFO - TEST-START | kraken 19:05:49 INFO - operating with platform_type : linux_ 19:05:49 INFO - Initialising browser for kraken test... 19:05:49 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:53835/getInfo.html -profile /tmp/tmpjSX94Y/profile 19:05:49 INFO - TEST-INFO | started process 5537 (/builds/slave/test/build/application/firefox/firefox http://localhost:53835/getInfo.html) 19:06:24 INFO - TEST-INFO | 5537: killed by SIGTERM 19:06:24 INFO - Browser initialized. 19:06:24 INFO - Running cycle 1/1 for kraken test... 19:06:24 INFO - TEST-INFO | started process 5757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjSX94Y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:06:36 INFO - PID 5757 | RSS: Main: 177012736 19:06:36 INFO - PID 5757 | 19:06:39 INFO - PID 5757 | Cycle 1(1): loaded http://localhost:53835/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53835/tests/kraken/driver.html?testName=audio-beat-detection) 19:06:40 INFO - PID 5757 | RSS: Main: 182210560 19:06:40 INFO - PID 5757 | 19:06:42 INFO - PID 5757 | Cycle 1(1): loaded http://localhost:53835/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53835/tests/kraken/driver.html?testName=audio-dft) 19:06:43 INFO - PID 5757 | RSS: Main: 181051392 19:06:43 INFO - PID 5757 | 19:06:46 INFO - PID 5757 | Cycle 1(1): loaded http://localhost:53835/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53835/tests/kraken/driver.html?testName=audio-fft) 19:06:47 INFO - PID 5757 | RSS: Main: 178651136 19:06:47 INFO - PID 5757 | 19:06:49 INFO - PID 5757 | Cycle 1(1): loaded http://localhost:53835/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53835/tests/kraken/driver.html?testName=audio-oscillator) 19:06:49 INFO - PID 5757 | RSS: Main: 178614272 19:06:49 INFO - PID 5757 | 19:06:52 INFO - PID 5757 | Cycle 1(1): loaded http://localhost:53835/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53835/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:06:52 INFO - PID 5757 | RSS: Main: 178827264 19:06:52 INFO - PID 5757 | 19:06:55 INFO - PID 5757 | Cycle 1(1): loaded http://localhost:53835/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53835/tests/kraken/driver.html?testName=imaging-darkroom) 19:06:56 INFO - PID 5757 | RSS: Main: 180232192 19:06:56 INFO - PID 5757 | 19:06:59 INFO - PID 5757 | Cycle 1(1): loaded http://localhost:53835/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53835/tests/kraken/driver.html?testName=imaging-desaturate) 19:07:00 INFO - PID 5757 | RSS: Main: 179458048 19:07:00 INFO - PID 5757 | 19:07:03 INFO - PID 5757 | Cycle 1(1): loaded http://localhost:53835/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53835/tests/kraken/driver.html?testName=json-parse-financial) 19:07:04 INFO - PID 5757 | RSS: Main: 180494336 19:07:04 INFO - PID 5757 | 19:07:05 INFO - PID 5757 | Cycle 1(1): loaded http://localhost:53835/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53835/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:07:06 INFO - PID 5757 | RSS: Main: 180281344 19:07:06 INFO - PID 5757 | 19:07:08 INFO - PID 5757 | Cycle 1(1): loaded http://localhost:53835/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53835/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:07:08 INFO - PID 5757 | RSS: Main: 179953664 19:07:08 INFO - PID 5757 | 19:07:11 INFO - PID 5757 | Cycle 1(1): loaded http://localhost:53835/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53835/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:07:11 INFO - PID 5757 | RSS: Main: 180498432 19:07:11 INFO - PID 5757 | 19:07:14 INFO - PID 5757 | Cycle 1(1): loaded http://localhost:53835/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53835/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:07:15 INFO - PID 5757 | RSS: Main: 180273152 19:07:15 INFO - PID 5757 | 19:07:18 INFO - PID 5757 | Cycle 1(1): loaded http://localhost:53835/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53835/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:07:19 INFO - PID 5757 | RSS: Main: 180330496 19:07:19 INFO - PID 5757 | 19:07:20 INFO - PID 5757 | Cycle 1(1): loaded http://localhost:53835/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53835/tests/kraken/driver.html?testName=ai-astar) 19:07:21 INFO - PID 5757 | RSS: Main: 181489664 19:07:21 INFO - PID 5757 | 19:07:21 INFO - PID 5757 | __start_tp_report 19:07:21 INFO - PID 5757 | _x_x_mozilla_page_load 19:07:21 INFO - PID 5757 | _x_x_mozilla_page_load_details 19:07:21 INFO - PID 5757 | |i|pagename|runs| 19:07:21 INFO - PID 5757 | |0;ai-astar;107;113;113;112;111;111;111;112;111;112 19:07:21 INFO - PID 5757 | |1;audio-beat-detection;148;129;127;180;124;123;124;124;145;125 19:07:21 INFO - PID 5757 | |2;audio-dft;165;165;165;165;174;169;171;164;168;164 19:07:21 INFO - PID 5757 | |3;audio-fft;74;74;74;114;74;74;74;73;92;75 19:07:21 INFO - PID 5757 | |4;audio-oscillator;84;83;104;84;83;84;110;84;84;104 19:07:21 INFO - PID 5757 | |5;imaging-gaussian-blur;114;115;114;114;115;114;114;115;114;114 19:07:21 INFO - PID 5757 | |6;imaging-darkroom;150;150;151;151;150;151;151;150;151;150 19:07:21 INFO - PID 5757 | |7;imaging-desaturate;96;95;96;94;94;95;94;95;95;94 19:07:21 INFO - PID 5757 | |8;json-parse-financial;55;55;53;56;56;57;58;61;56;56 19:07:21 INFO - PID 5757 | |9;json-stringify-tinderbox;56;57;57;57;56;59;56;56;57;57 19:07:21 INFO - PID 5757 | |10;stanford-crypto-aes;85;88;89;87;86;97;88;88;113;87 19:07:21 INFO - PID 5757 | |11;stanford-crypto-ccm;136;137;134;136;146;142;135;135;138;135 19:07:21 INFO - PID 5757 | |12;stanford-crypto-pbkdf2;199;194;197;203;205;200;205;203;202;201 19:07:21 INFO - PID 5757 | |13;stanford-crypto-sha256-iterative;74;77;73;79;75;71;73;77;79;75 19:07:21 INFO - PID 5757 | __end_tp_report 19:07:21 INFO - PID 5757 | __start_cc_report 19:07:21 INFO - PID 5757 | _x_x_mozilla_cycle_collect,890 19:07:21 INFO - PID 5757 | __end_cc_report 19:07:21 INFO - PID 5757 | __startTimestamp1495678041242__endTimestamp 19:07:21 INFO - PID 5757 | 19:07:21 INFO - PID 5757 | ------- Summary: start ------- 19:07:21 INFO - PID 5757 | Number of tests: 14 19:07:21 INFO - PID 5757 | 19:07:21 INFO - PID 5757 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:1.70 (1.5%) stddev-sans-first:0.83 19:07:21 INFO - PID 5757 | Values: 107.0 113.0 113.0 112.0 111.0 111.0 111.0 112.0 111.0 112.0 19:07:21 INFO - PID 5757 | 19:07:21 INFO - PID 5757 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:128.00 stddev:18.26 (14.3%) stddev-sans-first:18.74 19:07:21 INFO - PID 5757 | Values: 148.0 129.0 127.0 180.0 124.0 123.0 124.0 124.0 145.0 125.0 19:07:21 INFO - PID 5757 | 19:07:21 INFO - PID 5757 | [#2] audio-dft Cycles:10 Average:167.00 Median:166.50 stddev:3.40 (2.0%) stddev-sans-first:3.53 19:07:21 INFO - PID 5757 | Values: 165.0 165.0 165.0 165.0 174.0 169.0 171.0 164.0 168.0 164.0 19:07:21 INFO - PID 5757 | 19:07:21 INFO - PID 5757 | [#3] audio-fft Cycles:10 Average:79.80 Median:74.00 stddev:13.29 (18.0%) stddev-sans-first:13.93 19:07:21 INFO - PID 5757 | Values: 74.0 74.0 74.0 114.0 74.0 74.0 74.0 73.0 92.0 75.0 19:07:21 INFO - PID 5757 | 19:07:21 INFO - PID 5757 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:84.00 stddev:10.90 (13.0%) stddev-sans-first:11.31 19:07:21 INFO - PID 5757 | Values: 84.0 83.0 104.0 84.0 83.0 84.0 110.0 84.0 84.0 104.0 19:07:21 INFO - PID 5757 | 19:07:21 INFO - PID 5757 | [#5] imaging-gaussian-blur Cycles:10 Average:114.30 Median:114.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 19:07:21 INFO - PID 5757 | Values: 114.0 115.0 114.0 114.0 115.0 114.0 114.0 115.0 114.0 114.0 19:07:21 INFO - PID 5757 | 19:07:21 INFO - PID 5757 | [#6] imaging-darkroom Cycles:10 Average:150.50 Median:151.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 19:07:21 INFO - PID 5757 | Values: 150.0 150.0 151.0 151.0 150.0 151.0 151.0 150.0 151.0 150.0 19:07:21 INFO - PID 5757 | 19:07:21 INFO - PID 5757 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.71 19:07:21 INFO - PID 5757 | Values: 96.0 95.0 96.0 94.0 94.0 95.0 94.0 95.0 95.0 94.0 19:07:21 INFO - PID 5757 | 19:07:21 INFO - PID 5757 | [#8] json-parse-financial Cycles:10 Average:56.30 Median:56.00 stddev:2.11 (3.8%) stddev-sans-first:2.19 19:07:21 INFO - PID 5757 | Values: 55.0 55.0 53.0 56.0 56.0 57.0 58.0 61.0 56.0 56.0 19:07:21 INFO - PID 5757 | 19:07:21 INFO - PID 5757 | [#9] json-stringify-tinderbox Cycles:10 Average:56.80 Median:57.00 stddev:0.92 (1.6%) stddev-sans-first:0.93 19:07:21 INFO - PID 5757 | Values: 56.0 57.0 57.0 57.0 56.0 59.0 56.0 56.0 57.0 57.0 19:07:21 INFO - PID 5757 | 19:07:21 INFO - PID 5757 | [#10] stanford-crypto-aes Cycles:10 Average:90.80 Median:88.00 stddev:8.46 (9.6%) stddev-sans-first:8.71 19:07:21 INFO - PID 5757 | Values: 85.0 88.0 89.0 87.0 86.0 97.0 88.0 88.0 113.0 87.0 19:07:21 INFO - PID 5757 | 19:07:21 INFO - PID 5757 | [#11] stanford-crypto-ccm Cycles:10 Average:137.40 Median:136.50 stddev:3.78 (2.8%) stddev-sans-first:3.97 19:07:21 INFO - PID 5757 | Values: 136.0 137.0 134.0 136.0 146.0 142.0 135.0 135.0 138.0 135.0 19:07:21 INFO - PID 5757 | 19:07:21 INFO - PID 5757 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:200.90 Median:202.50 stddev:3.51 (1.7%) stddev-sans-first:3.66 19:07:21 INFO - PID 5757 | Values: 199.0 194.0 197.0 203.0 205.0 200.0 205.0 203.0 202.0 201.0 19:07:21 INFO - PID 5757 | 19:07:21 INFO - PID 5757 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.30 Median:76.00 stddev:2.67 (3.5%) stddev-sans-first:2.79 19:07:21 INFO - PID 5757 | Values: 74.0 77.0 73.0 79.0 75.0 71.0 73.0 77.0 79.0 75.0 19:07:21 INFO - PID 5757 | -------- Summary: end -------- 19:07:21 INFO - PID 5757 | 19:07:22 INFO - TEST-INFO | 5757: exit 0 19:07:22 INFO - TEST-OK | kraken | took 92420ms 19:07:22 INFO - SUITE-END | took 1238s 19:07:22 INFO - Completed test suite (00:20:38) 19:07:22 INFO - javascript benchmark 19:07:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6717.818833850443, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2719.9456010879785, 2732.740389662981, 2754.187514683168, 2774.30642339415, 2777.652793400825, 5193.45468725784, 5246.081935661263, 5273.8945221095555, 5274.077036518613, 5331.333583302083, 5166.767495462704, 5231.424543300234, 5262.131748261532, 5313.20301954707, 5330.706811125387, 4696.788644510988, 4697.765111744417, 4702.553257440555, 4733.5739783419485, 4774.68964517307, 4694.671373003891, 4736.526347365253, 4768.570828625423, 4779.450363208223, 4817.614590832725, 4647.9535204647855, 4670.206064968964, 4703.623710103184, 4710.599599034086, 4738.147133515966, 4673.532646735333, 4702.247640377524, 4710.693804902705, 4745.976270118627, 4749.097671442415, 4670.182718024332, 4687.156311863863, 4687.9531204687855, 4704.553067458586, 4750.097481478508, 5096.923546146811, 5242.056429842627, 5259.605529585297, 5292.629515933886, 5337.839864804062, 5700.7149642518125, 5703.258576385043, 5711.9718450678865, 5722.2561067061015, 5755.223044888929, 5762.567807414461, 5764.0, 5765.1928729977835, 5775.48020678141, 5824.242848429677, 5316.388615309212, 5328.6802791832615, 5331.333583302087, 5332.786688532416, 5333.466653334635, 5708.914366284509, 5781.161731548986, 5798.710064496759, 5855.092460668603, 5864.120381942743, 5538.363088244822, 5539.612227144142, 5547.694876781816, 5590.552755779528, 5601.439856014366, 5717.371089180187, 5736.62711923732, 5737.913931291034, 5740.54075673945, 5753.424657534213, 5576.414476479992, 5598.104303311532, 5722.656640601577, 5723.627964182315, 5730.684812335361, 5595.860103497445, 5614.410486898817, 5637.379888212294, 5688.715564221772, 5699.059655156935, 4698.671093023456, 4701.388819453449, 4704.15325241453, 4704.5765881070865, 4739.502352253033, 4041.1109555897656, 4045.3527435610163, 4048.554658987509, 4081.224567332257, 4113.362428823537, 4719.811207551659, 4748.264019077049, 4819.060283244734, 4844.757762111951, 4895.730734809548, 5758.280214973129, 5791.276090488689, 5806.361300256968, 5825.912611310834, 5841.153032810219, 4872.366592342973, 4874.902501949941, 4879.121758083508, 4884.1941079722155, 4913.877153071202, 4886.535779101051, 5033.79864805411, 5039.21892106724, 5050.520200580939, 5054.848354549369, 5340.412554618911, 5353.0, 5371.758270877742, 5436.537894278872, 5468.644538105011, 5615.8876822464135, 5705.885882282414, 5767.9134812977, 5800.1589769484035, 5821.0, 5333.7866485340155, 5338.492843179892, 5383.327084114486, 5384.19237114436, 5427.158790387496, 5623.662580245198, 5654.491095801398, 5657.886842263049, 5671.8865622688145, 5672.290963629546, 5593.440655934374, 5687.829365119053, 5756.107803290497, 5784.623999440023, 5786.942130578809, 5475.589330800126, 5520.585956053232, 5540.390557038642, 5542.002439560918, 5570.387257401763, 5513.558915286848, 5543.307086614173, 5557.138643510262, 5567.860803479945, 5574.219609254626, 5417.837464875903, 5462.153366228241, 5467.644603100785, 5469.425710300361, 5509.944900551103, 5488.313960754906, 5541.944580554304, 5574.717814902676, 5596.552275818006, 5619.8595035124445, 5416.891662166656, 5438.755256013568, 5446.264754258124, 5448.237246785532, 5507.421720719267], "value": 5169.54396469742, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [628.8019273928712, 678.7963610916726, 699.2308460693237, 1123.8258069999147, 1184.2480025184016, 33331.83334083329, 34923.126921826966, 34928.476072858895, 35009.0, 35035.47446788294, 33198.66801331986, 33400.49899251513, 33532.32935341292, 33582.83208583954, 33594.0, 6277.058441233818, 6426.903596446057, 6529.2817790043055, 6744.966275168642, 6746.527743057988, 6800.183977922657, 6838.897416538756, 6919.342662447085, 6939.23668396476, 6939.618320992344, 6909.758158464455, 6932.306769323078, 6942.375186233238, 6952.965235173817, 6982.825429364256, 6910.0, 6924.792256232321, 6937.583744975267, 6938.09804725385, 6941.930580694229, 6681.76613818514, 6727.058211850345, 6727.461803055744, 6728.899066514006, 6733.293004234534, 31256.687433125604, 31494.842525787226, 31541.684583154332, 31542.369152617048, 31575.052748417584, 3037.711417415342, 3078.291992841637, 3078.3227689908185, 3082.321889184376, 3086.753059755214, 24587.508249834904, 24634.630480542804, 24667.753322466724, 24691.38271543208, 24751.133710320053, 2958.685913389746, 2973.4945059339966, 2988.970110298891, 3020.7130322619314, 3075.3388021575247, 138930.0, 139663.30168349194, 139680.0, 145996.0, 146964.0, 39794.20411591752, 39815.60184398119, 40069.39895901564, 40108.98365245236, 40161.39757903634, 40907.386389204185, 41017.79491102525, 41045.1790964179, 41196.79401602973, 43105.784471077444, 13019.088663793444, 13084.869151308556, 13136.60590182277, 13167.67080822968, 13191.40638671243, 10422.791544169075, 10510.684679459475, 10530.57877684884, 10537.89462105369, 10548.894511054945, 12749.42627581761, 12754.298513581842, 12795.360231988363, 12834.0, 12880.935595321964, 5358.544523715528, 5373.435789242151, 5462.934727728134, 5469.425710300441, 5486.423925487846, 832.6003518311123, 893.3746377535621, 905.7961958559272, 909.8498747706686, 917.3165991336497, 20077.598448030956, 21002.264920727703, 21005.579888402146, 21149.365519034454, 21321.629066041423, 968.5689868008668, 969.762408209979, 983.955721992512, 990.8266053440619, 993.1707024634511, 10403.947980260202, 11059.778804423866, 11107.777844443066, 11146.331220126818, 11321.0, 170478.0, 170790.0, 171210.0, 171301.0, 171310.0, 40376.39435408471, 40651.59348406537, 40714.0, 40755.7962210193, 40835.591644083775, 1207.1851500237306, 1226.576830993306, 1241.267652085274, 1245.5640525816073, 1255.6735248835369, 19240.615187696447, 19913.900430498335, 20564.794352056888, 20600.38198854037, 20858.165673373504, 28855.711442886142, 36407.817960910026, 37570.81214594019, 37596.0, 37735.433968489946, 161225.0, 161464.0, 162550.18724906773, 162628.18685906968, 162741.0, 30087.69912300849, 30181.849090755284, 30254.697453025186, 30388.544171837, 30596.0, 34654.82672586621, 35265.29469410649, 35715.46426803548, 35742.64257357497, 35883.82058089693, 26473.205803825917, 26815.731842682104, 26976.0, 27478.0382686605, 27712.58431123575, 23461.648075278543, 24081.277561673178, 24113.879430602734, 24199.75800241975, 24616.753832462164, 29367.559486608145, 29494.557581636724, 29740.0, 29839.701602983692, 29993.250168745082, 25945.610815838154, 26182.34544136412, 26551.33621659474, 26976.865115675082, 27458.17625471239, 19733.506662332984, 20394.490137746674, 20450.48873778108, 20485.897570512054, 20489.897550512153], "value": 14429.085897514007, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.66113803267206, 401.752921952999, 410.29224587586407, 422.35590724145686, 435.2600579015672, 17009.829901700978, 17444.56388590286, 17908.104594770273, 17911.462656120322, 18044.63910721785, 16665.083420411902, 16832.0, 16867.0, 17813.554661133447, 18861.717074243898, 5444.482774136461, 5603.80386686466, 5634.746436410372, 5648.124540696199, 5653.886922261552, 5254.448282930294, 5393.460653934614, 5407.864803379927, 5442.510174084332, 5454.481824226692, 5396.43337449568, 5409.188621706736, 5412.052890744104, 5412.783488660449, 5443.1835224716215, 5314.149736042234, 5414.512693857552, 5506.944930550703, 5518.172274158868, 5532.336119665666, 4971.304017437562, 4984.053029924303, 5002.0, 5002.974985125051, 5014.122528557525, 21111.0, 21176.470588235265, 21612.675809862863, 21654.89172554143, 21671.566568668695, 1607.7990251218598, 1614.1848366574923, 1619.983800161995, 1619.9919000404923, 1624.285314461645, 13911.234882081482, 13919.0, 13962.790558141636, 13985.79021314681, 14308.0, 2027.7262569553216, 2040.5000774810119, 2060.5878824235065, 2095.9266425675182, 2102.9474263143543, 83871.0, 84458.57770711106, 84834.57582712047, 85028.0, 85409.0, 11043.171762117712, 11145.275557088764, 11153.832692509619, 11179.83230251547, 11396.373199474108, 15477.22613869302, 15625.218739063, 15641.452549160726, 15669.216539172996, 15707.214639267992, 7676.424268179909, 7759.534427934229, 7911.349697851169, 7923.603819808986, 7972.521648701097, 7240.855182896313, 7276.818079548054, 7292.525985811011, 7457.105147382349, 7499.812504687427, 6839.093385311322, 7026.332498412643, 7037.753678621326, 7046.582407532343, 7073.540219885691, 1933.3136736458355, 1997.340877510418, 2010.6380851446588, 2011.8591698581251, 2031.9288824891057, 840.2311884625499, 877.7586163804878, 883.3463237204422, 890.470170248701, 901.1304091551684, 15806.446774362843, 15863.714953387436, 16238.188090595422, 16510.917445412935, 16753.664926701396, 864.4683519635505, 878.0648609231276, 881.4006475596527, 885.5173930208052, 904.0959040959041, 8784.907620612636, 8850.73447796567, 8986.370954033286, 9120.315976301805, 9166.22087122602, 348843.25578372454, 354304.0265570785, 360681.0, 378121.0, 383531.0, 66976.95811065541, 75245.6237718808, 80354.19645803585, 81433.0, 84041.15958840333, 1066.9466526673634, 1075.4138994248153, 1120.227043340109, 1127.3179726265655, 1129.7909886670993, 16342.428015019417, 16767.24547395346, 17185.31258749636, 17311.653766924843, 17494.212760426068, 38750.80624596859, 39059.218815624095, 39178.02054948649, 39648.40527392149, 39897.0, 48925.2661210075, 49341.2598811011, 49540.0, 50078.49921500738, 50982.0, 7582.317591416579, 7649.923500765144, 7681.964279466058, 7751.844963100593, 7757.185495523115, 10963.725906852393, 11040.116790656888, 11304.773904521699, 11575.479103440197, 11632.54593175853, 9656.71029869105, 9823.459709716035, 9826.361286516354, 10147.79704405893, 10381.896181038093, 9551.952240238754, 9587.760305992406, 9635.5663995119, 9666.468344241135, 9736.561854716696, 9742.464164471023, 9925.751856203653, 9927.702168934655, 10228.07947284748, 10462.581496740046, 7972.760817175494, 8112.594370281345, 8405.285550728257, 8473.364497662576, 8479.0, 10446.425446600206, 10546.419946902994, 10726.73183170427, 10735.785284294427, 10887.401192934465], "value": 8674.250276909397, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1248.9375531223438, 1292.2182079841696, 1302.9283389413579, 1304.3739005277464, 1306.105317857268, 10291.382517048982, 10535.209859260547, 10830.296030758005, 10873.728156796074, 10886.782264354708, 10270.281080324361, 10396.0, 10422.843657345145, 10430.269881108325, 10447.477626118683, 2201.1195521791333, 2221.455743342883, 2223.5775202711434, 2237.2281562860785, 2250.909963601454, 2118.142152428269, 2168.1219106261988, 2168.360333701562, 2174.7825217478285, 2176.3906106290265, 2091.393495886191, 2154.202944910385, 2162.4269568564264, 2166.9024893879814, 2171.5873983943, 2074.9273775417864, 2091.592139532792, 2103.663413853776, 2110.2508609443657, 2118.6610142377144, 1838.5219842840825, 1912.0917564157053, 1999.1803360622075, 2049.1700861151107, 2159.9784002159936, 10728.517216725188, 10765.677029689123, 10831.620893268699, 10865.945670271678, 10883.129349652008, 5454.772676147874, 5703.0, 5715.771369145229, 5718.542516598662, 5721.0, 3171.1437911763924, 3292.983535082333, 3370.7303415726683, 3371.7302615790677, 3385.4752513360468, 1066.2909165404997, 1070.4219721350462, 1075.5805235957982, 1079.854219680341, 1100.5267734874, 15775.0, 15940.920295398564, 16009.0, 16024.0, 16056.518304450885, 4488.753118578509, 4616.799632095612, 4765.499622539653, 4775.6657034007285, 4799.112164249625, 11072.612458563912, 11077.169212309109, 11086.390248536409, 11098.2786118902, 11099.445027748741, 5514.283143191359, 5610.775568977195, 5611.354694210218, 5628.296462942132, 5642.576806739511, 5159.045576568272, 5195.610329225247, 5228.9477105229225, 5246.501582349671, 5257.2639830423, 3683.2633473305445, 3760.2667479841716, 3779.5464544254864, 3813.904652383713, 3894.7078969077434, 1021.1320377678913, 1030.6804890483975, 1039.365986748083, 1052.3265110329241, 1058.4178701714027, 676.587281758137, 685.2667645619239, 690.0373978300344, 705.1221229569219, 706.2513735440347, 5229.163333866563, 5288.418273989858, 5314.441983591667, 5483.232347471358, 5499.202615620713, 504.20335869326374, 529.9867503312448, 534.7219445888194, 535.4056996733623, 537.4249552978354, 3244.9837750811093, 3337.3158502506926, 3424.072418082553, 3433.4163192257374, 3589.174489867345, 13303.0, 13900.374483148282, 14246.572602821932, 14286.499972500913, 14301.0, 13861.86138138626, 13924.164550127025, 13953.511627093003, 14064.648383790487, 14137.293135343192, 7219.628270628564, 7479.214682458372, 7508.0, 7586.431017673696, 7597.088349398107, 5374.167004114369, 5403.270558474555, 5405.108157154025, 5502.972485137709, 5622.156676498558, 12387.938060309642, 12450.25298482094, 12501.124921255425, 12610.49558017669, 12783.041271904458, 12541.369621949088, 13006.0, 13095.017873659704, 13171.802422963472, 13183.209007459584, 8546.059933407196, 8624.137586241326, 8659.567021648767, 8732.388732788899, 8732.78168045804, 9516.286278529, 9552.092551207625, 9556.904430955601, 9576.904230957602, 9585.185259253041, 8527.06202317757, 8562.143785621638, 8566.657333706582, 8694.608742606724, 8739.694110706096, 8359.95820020896, 8432.494050356998, 8443.915560844558, 8606.440581362442, 8656.610452529778, 7415.592142432002, 7548.433867460072, 7549.245075492407, 7563.886541701769, 7578.621068946641, 4346.847860325, 4961.627877909099, 5043.697378157322, 5062.139436295912, 5090.821821236239, 4999.275105109666, 5159.922601161061, 5238.68567885928, 5240.2663627093, 5301.761420736153], "value": 4677.614188003161, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.9705075068619, 366.6242101845608, 368.10366756946826, 376.3940056509018, 376.41279603818043, 5418.566514678826, 5564.221009058725, 5570.387257401688, 5604.943950560493, 5638.407967163445, 5358.705271210082, 5402.837914862561, 5409.918851217235, 5419.349678038631, 5425.294711687485, 4060.553339132693, 4061.6750659947133, 4069.9999999999927, 4074.9592504074876, 4093.7953102344763, 3940.5074365704286, 4072.328065869143, 4080.469538959931, 4089.5092588889374, 4089.652379547742, 4024.517057953035, 4057.127717540728, 4068.125353049094, 4069.726786873771, 4095.221907837516, 4048.1903619276263, 4048.3725022621543, 4055.8377664893665, 4056.472658554384, 4059.2084543514025, 3500.789952602852, 3518.9296214075575, 3521.1725244567506, 3521.9823900880588, 3524.0, 5239.318888544465, 5326.92009619856, 5340.67955922642, 5358.705271210082, 5359.196120581905, 4742.857714268577, 4748.881277968044, 4753.595944344735, 4776.832810851638, 4797.040591881638, 5604.8038318658655, 5721.828345149652, 5748.367679555246, 5752.194692743019, 5773.2494775679315, 3925.3130702127014, 3939.212157568469, 3964.86122985697, 3967.662748666367, 3968.464257325282, 5880.764769409218, 6103.206583144207, 6105.694715264263, 6110.327863934964, 6145.661988590626, 4026.1545075534464, 4033.4353190553347, 4034.8184331705143, 4060.553339132693, 4062.857799976987, 4111.342185250405, 4111.506619205715, 4116.485439320085, 4118.155778065549, 4123.958760412357, 4699.295105734167, 4747.287906813936, 4767.928481072787, 4776.546228108394, 4783.145107715672, 5777.913331300034, 5784.739686714108, 5786.846168837993, 5796.710164491843, 5826.650400975955, 1395.6929475515371, 1398.7132637809225, 1399.293356854782, 1401.10329389191, 1403.6982048859545, 893.6693423433371, 933.7152168588646, 948.137195152408, 957.8323793336139, 958.2765012415582, 5009.123403404463, 5022.447530771612, 5024.57291130258, 5026.89946201074, 5031.496850314939, 5933.584649074523, 5948.512871782054, 5970.0, 5989.401059894063, 5997.820065398045, 4867.756612169448, 5002.649814513022, 5006.89986200274, 5027.195648696191, 5031.823886163967, 3159.988803582831, 3166.398384306974, 3168.98415507921, 3178.3631429813663, 3181.3637272545584, 5549.556035517149, 5629.211910332557, 5640.266765320482, 5653.886922261532, 5680.7727690892725, 6096.237970253718, 6116.174316467309, 6129.295131059986, 6133.447989680861, 6157.384261573897, 5604.271444712162, 5610.551155907436, 5645.153227015899, 5658.094704847204, 5658.886822263614, 5867.354590995073, 5963.671998039976, 5964.433378829004, 5964.880702385841, 5993.31076926159, 5881.264841894763, 5909.6158749681135, 5916.31962324321, 5922.0, 5931.584789064724, 5457.536109430743, 5586.441355864381, 5627.352854421631, 5629.718514074362, 5653.297090405791, 4031.2061132795625, 4031.3146765049423, 4035.1324465240114, 4045.352743561134, 4054.310767169647, 5942.7920022799, 6041.697915104315, 6088.726007329592, 6088.908666369919, 6115.174451448997, 5806.883862322646, 5820.73806678692, 5838.795642152674, 5843.422275985545, 5857.560682948711, 5784.293633378079, 5806.82579522615, 5807.477327040587, 5827.1841942127285, 5850.444207800252, 5557.3331200256225, 5672.773089076556, 5677.148427735872, 5710.8572285691525, 5717.17101020358, 5830.53355731549, 5849.239598852122, 5849.766009359578, 5857.824265272048, 5865.736041878211, 5602.561740230513, 5634.661920284796, 5634.74643641029, 5651.717414129195, 5686.180422265001], "value": 4297.277509888809, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.8888822232556, 728.4245446097583, 755.5693254844738, 759.4987308376473, 774.9728759493419, 13674.0, 14304.427822887099, 14467.565973020814, 15049.54851354461, 15599.376024959016, 15981.440649577267, 16039.198040098006, 16051.598710032255, 16153.111578863158, 16174.110423926708, 872.1191596487562, 887.8535041718109, 888.9377743557953, 889.715291106846, 894.9463032218088, 903.530164314556, 905.3255324783046, 905.4748246017327, 906.5286051253345, 908.454927043775, 886.0829041941591, 900.8513595256808, 906.9047749986255, 909.3861643390718, 910.1353713971753, 905.0858632780872, 905.3933864310927, 906.714384968736, 907.8865141857268, 908.3823000359786, 664.7673314339991, 666.4601672645173, 666.8266250774785, 668.011343212044, 668.6489592963733, 14142.92928535361, 14378.496752613608, 14382.856171438256, 14384.35270412834, 14407.423703051865, 15615.453459128876, 15894.443694470638, 16395.344186232538, 16421.178941052898, 16421.91789041059, 12061.93969030158, 12250.571230006906, 12364.690882727913, 12393.75212495754, 12500.187487813353, 3102.612173478315, 3109.2226943264186, 3118.1269244611544, 3122.6252849658185, 3126.234072652192, 83113.16886831114, 83553.0, 84383.57808210919, 84539.0, 84975.99999999939, 12241.265524068584, 12316.938415307866, 12339.814902776465, 12386.876131238752, 12404.379781010914, 20253.0, 20787.272445464638, 20854.58290834175, 20869.478263043242, 21008.369748907557, 5826.184334193216, 5842.269716285465, 5874.588778785529, 5888.3228428731245, 5898.557608179318, 2829.858507074638, 2848.430313937221, 2867.526858068437, 2880.625518682558, 2894.3777087926196, 3765.981170094187, 3846.0961674006585, 3871.7676939383164, 3880.2433525462266, 3885.0, 666.0841343153164, 673.9898901516481, 676.1851968378093, 676.2189670930084, 677.075791544548, 592.1916583862997, 607.0782743477099, 618.4712071179167, 624.0452108274347, 624.4785604020602, 9544.284178686627, 9938.850917236246, 10018.198544116452, 10406.323588966692, 10867.076298514714, 505.23709199108873, 509.39636530711226, 511.2535697881135, 513.4095789841638, 515.2220147577185, 4350.6736994725525, 4495.415595972503, 4552.795124219418, 4567.680262381601, 4612.838550650711, 81589.18410815934, 81665.59167204244, 82061.0, 82796.0, 82899.5855020721, 76551.0, 76674.0, 76764.61617691988, 76825.61587192028, 77854.0, 60280.0, 61610.38389616136, 61942.380576195465, 62349.37650623436, 63615.23955477525, 10033.749156271151, 10335.364482057028, 10422.635207767691, 10605.151587872797, 11017.944910275397, 28048.0, 28130.578041329805, 28410.0, 28617.856910715313, 29641.555376668937, 35026.299474010884, 35240.82379588085, 35245.471317930766, 35772.4634130483, 36478.27043459169, 14686.63283417923, 14806.407743690132, 14864.331105100513, 14913.776293355391, 15042.323095460511, 15856.682866342839, 16097.436589719304, 16401.0, 16687.08221047854, 16712.41506547265, 14824.555263342118, 14897.553073407815, 15177.317020733874, 15216.0, 15453.304601293194, 12915.0, 13064.54274100402, 13210.801837972245, 13218.20690758519, 13272.535461258809, 13746.793798092836, 14359.497417590333, 14549.92725036368, 14699.706005879609, 14759.335829887896, 10895.673129806119, 11213.55145794159, 11321.320720756781, 11389.0, 11760.000399966098, 11691.883081169079, 12181.573644922386, 12222.938885305517, 12236.69408264765, 12486.875131248935], "value": 7066.384770256436, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1560.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 113.0, 113.0, 112.0, 111.0, 111.0, 111.0, 112.0, 111.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 129.0, 127.0, 180.0, 124.0, 123.0, 124.0, 124.0, 145.0, 125.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 165.0, 165.0, 174.0, 169.0, 171.0, 164.0, 168.0, 164.0], "value": 167.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 74.0, 114.0, 74.0, 74.0, 74.0, 73.0, 92.0, 75.0], "value": 79.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 104.0, 84.0, 83.0, 84.0, 110.0, 84.0, 84.0, 104.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 115.0, 114.0, 114.0, 115.0, 114.0, 114.0], "value": 114.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 151.0, 151.0, 150.0, 151.0, 151.0, 150.0, 151.0, 150.0], "value": 150.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 53.0, 56.0, 56.0, 57.0, 58.0, 61.0, 56.0, 56.0], "value": 56.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 57.0, 57.0, 56.0, 59.0, 56.0, 56.0, 57.0, 57.0], "value": 56.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 88.0, 89.0, 87.0, 86.0, 97.0, 88.0, 88.0, 113.0, 87.0], "value": 90.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 137.0, 134.0, 136.0, 146.0, 142.0, 135.0, 135.0, 138.0, 135.0], "value": 137.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 194.0, 197.0, 203.0, 205.0, 200.0, 205.0, 203.0, 202.0, 201.0], "value": 200.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 73.0, 79.0, 75.0, 71.0, 73.0, 77.0, 79.0, 75.0], "value": 75.3, "unit": "score"}]}]} 19:07:22 INFO - Return code: 0 19:07:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:07:22 INFO - # TBPL SUCCESS # 19:07:22 INFO - Running post-action listener: _resource_record_post_action 19:07:22 INFO - [mozharness: 2017-05-25 02:07:22.542538Z] Finished run-tests step (success) 19:07:22 INFO - Running post-run listener: _resource_record_post_run 19:07:22 INFO - Total resource usage - Wall time: 1255s; CPU: 13.0%; Read bytes: 4096; Write bytes: 424517632; Read time: 4; Write time: 315640 19:07:22 INFO - TinderboxPrint: CPU usage
12.8% 19:07:22 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 19:07:22 INFO - TinderboxPrint: I/O write bytes / time
424,517,632 / 315,640 19:07:22 INFO - TinderboxPrint: CPU idle
8,735.1 (87.2%) 19:07:22 INFO - TinderboxPrint: CPU user
1,227.6 (12.3%) 19:07:22 INFO - TinderboxPrint: Swap in / out
0 / 0 19:07:22 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 112013312; Read time: 0; Write time: 94520 19:07:22 INFO - run-tests - Wall time: 1239s; CPU: 13.0%; Read bytes: 0; Write bytes: 308109312; Read time: 0; Write time: 220584 19:07:23 INFO - Running post-run listener: _upload_blobber_files 19:07:23 INFO - Blob upload gear active. 19:07:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:07:23 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 19:07:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:07:23 INFO - (blobuploader) - INFO - Open directory for files ... 19:07:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:07:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:07:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:07:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:07:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:07:24 INFO - (blobuploader) - INFO - Done attempting. 19:07:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:07:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:07:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:07:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:07:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:07:25 INFO - (blobuploader) - INFO - Done attempting. 19:07:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:07:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:07:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:07:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:07:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:07:31 INFO - (blobuploader) - INFO - Done attempting. 19:07:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:07:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:07:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:07:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:07:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:07:34 INFO - (blobuploader) - INFO - Done attempting. 19:07:34 INFO - (blobuploader) - INFO - Iteration through files over. 19:07:34 INFO - Return code: 0 19:07:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:07:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:07:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40d9e7dd5219dd902a14c1add9b48a82d9b037c4456d77194f1830038c228d0acc4d3e803d382250c405103d079890dfc25dbe3f87b6107917ccf6ec507651da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c55959cacf14cd914c4340cef4fb9d259222cfc68a7d7d549b2ec240620c77f1052ca331ca1071118d47feacf817c4ddf28090effe45762d31707ed1751fdf3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b8a696376a34b84f19dc7922ad0af7b6226efbf61cb8a6e04fe2a980b8c2dd7fe737de6458c2ee61c74c0afbd836bff5f55d5ce07f44d8de934dca172f6dc0f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0604ac7d7b74bddbe4ce034cdac493e0b8257bd4d63cb6ac865c543786200e6a149e8d8990b973ee41a80ae233be4b4357c1398de696a05d4597ea08adba3339"} 19:07:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:07:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:07:34 INFO - Contents: 19:07:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40d9e7dd5219dd902a14c1add9b48a82d9b037c4456d77194f1830038c228d0acc4d3e803d382250c405103d079890dfc25dbe3f87b6107917ccf6ec507651da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c55959cacf14cd914c4340cef4fb9d259222cfc68a7d7d549b2ec240620c77f1052ca331ca1071118d47feacf817c4ddf28090effe45762d31707ed1751fdf3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b8a696376a34b84f19dc7922ad0af7b6226efbf61cb8a6e04fe2a980b8c2dd7fe737de6458c2ee61c74c0afbd836bff5f55d5ce07f44d8de934dca172f6dc0f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0604ac7d7b74bddbe4ce034cdac493e0b8257bd4d63cb6ac865c543786200e6a149e8d8990b973ee41a80ae233be4b4357c1398de696a05d4597ea08adba3339"} 19:07:34 INFO - Running post-run listener: copy_logs_to_upload_dir 19:07:34 INFO - Copying logs to upload dir... 19:07:34 INFO - mkdir: /builds/slave/test/build/upload/logs 19:07:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1316.847280 ========= master_lag: 0.19 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-05-24 19:07:34.718206) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-24 19:07:34.722237) ========= 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=62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060 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/sha512/40d9e7dd5219dd902a14c1add9b48a82d9b037c4456d77194f1830038c228d0acc4d3e803d382250c405103d079890dfc25dbe3f87b6107917ccf6ec507651da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c55959cacf14cd914c4340cef4fb9d259222cfc68a7d7d549b2ec240620c77f1052ca331ca1071118d47feacf817c4ddf28090effe45762d31707ed1751fdf3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b8a696376a34b84f19dc7922ad0af7b6226efbf61cb8a6e04fe2a980b8c2dd7fe737de6458c2ee61c74c0afbd836bff5f55d5ce07f44d8de934dca172f6dc0f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0604ac7d7b74bddbe4ce034cdac493e0b8257bd4d63cb6ac865c543786200e6a149e8d8990b973ee41a80ae233be4b4357c1398de696a05d4597ea08adba3339"} build_url:https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://queue.taskcluster.net/v1/task/EV_sYQgUTue77nB9Vgxa3Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40d9e7dd5219dd902a14c1add9b48a82d9b037c4456d77194f1830038c228d0acc4d3e803d382250c405103d079890dfc25dbe3f87b6107917ccf6ec507651da", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c55959cacf14cd914c4340cef4fb9d259222cfc68a7d7d549b2ec240620c77f1052ca331ca1071118d47feacf817c4ddf28090effe45762d31707ed1751fdf3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1b8a696376a34b84f19dc7922ad0af7b6226efbf61cb8a6e04fe2a980b8c2dd7fe737de6458c2ee61c74c0afbd836bff5f55d5ce07f44d8de934dca172f6dc0f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0604ac7d7b74bddbe4ce034cdac493e0b8257bd4d63cb6ac865c543786200e6a149e8d8990b973ee41a80ae233be4b4357c1398de696a05d4597ea08adba3339"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-24 19:07:34.746807) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 19:07:34.747147) ========= 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=62c568580acbfdaac3eec7be000001dc-1495676736.456693-555306060 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004512 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 19:07:34.830644) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-24 19:07:34.830959) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-24 19:07:34.831263) ========= ========= Total master_lag: 0.34 =========