builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-011 starttime: 1495640878.08 results: success (0) revision: e84acaf49a8f5032864a2602c1c61b68ceb1b773 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-24 08:47:58.080636) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-24 08:47:58.081085) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-24 08:47:58.081358) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-24 08:47:58.096645) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 08:47:58.096975) ========= 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=5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-24 08:47:58-- 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% 223M=0s 2017-05-24 08:47:58 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.178142 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 08:47:58.290996) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 08:47:58.291309) ========= 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=5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020703 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 08:47:58.340396) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 08:47:58.340719) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e84acaf49a8f5032864a2602c1c61b68ceb1b773 --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 e84acaf49a8f5032864a2602c1c61b68ceb1b773 --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=5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-24 08:47:58,498 truncating revision to first 12 chars 2017-05-24 08:47:58,498 Setting DEBUG logging. 2017-05-24 08:47:58,498 attempt 1/10 2017-05-24 08:47:58,498 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e84acaf49a8f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-24 08:47:58,814 unpacking tar archive at: mozilla-central-e84acaf49a8f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626698 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 08:47:58.983164) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-24 08:47:58.983508) ========= script_repo_revision: e84acaf49a8f5032864a2602c1c61b68ceb1b773 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-24 08:47:58.986902) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-24 08:47:58.987172) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-24 08:47:58.995675) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-05-24 08:47:58.995960) ========= /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=5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:47:59 INFO - MultiFileLogger online at 20170524 08:47:59 in /builds/slave/test 08:47:59 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 08:47:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:47:59 INFO - {'append_to_log': False, 08:47:59 INFO - 'base_work_dir': '/builds/slave/test', 08:47:59 INFO - 'blob_upload_branch': 'Firefox', 08:47:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:47:59 INFO - 'branch': 'Firefox', 08:47:59 INFO - 'buildbot_json_path': 'buildprops.json', 08:47:59 INFO - 'config_files': ('talos/linux_config.py',), 08:47:59 INFO - 'default_actions': ('clobber', 08:47:59 INFO - 'read-buildbot-config', 08:47:59 INFO - 'download-and-extract', 08:47:59 INFO - 'populate-webroot', 08:47:59 INFO - 'create-virtualenv', 08:47:59 INFO - 'install', 08:47:59 INFO - 'run-tests'), 08:47:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:47:59 INFO - 'download_minidump_stackwalk': True, 08:47:59 INFO - 'download_symbols': 'ondemand', 08:47:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:47:59 INFO - 'tooltool.py': '/tools/tooltool.py', 08:47:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:47:59 INFO - '/tools/misc-python/virtualenv.py')}, 08:47:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:47:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:47:59 INFO - 'gecko_profile': False, 08:47:59 INFO - 'gecko_profile_interval': 0, 08:47:59 INFO - 'installer_path': 'installer.exe', 08:47:59 INFO - 'log_level': 'info', 08:47:59 INFO - 'log_name': 'talos', 08:47:59 INFO - 'log_to_console': True, 08:47:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:47:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:47:59 INFO - 'opt_config_files': (), 08:47:59 INFO - 'pip_index': False, 08:47:59 INFO - 'suite': 'dromaeojs-e10s', 08:47:59 INFO - 'system_bits': '32', 08:47:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:47:59 INFO - 'title': 'talos-linux64-ix-011', 08:47:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:47:59 INFO - 'use_talos_json': True, 08:47:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:47:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:47:59 INFO - 'work_dir': 'build'} 08:47:59 INFO - [mozharness: 2017-05-24 15:47:59.242516Z] Running clobber step. 08:47:59 INFO - Running pre-action listener: _resource_record_pre_action 08:47:59 INFO - Running main action method: clobber 08:47:59 INFO - rmtree: /builds/slave/test/build 08:47:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:48:01 INFO - Running post-action listener: _resource_record_post_action 08:48:01 INFO - [mozharness: 2017-05-24 15:48:01.079005Z] Finished clobber step (success) 08:48:01 INFO - [mozharness: 2017-05-24 15:48:01.079104Z] Running read-buildbot-config step. 08:48:01 INFO - Running pre-action listener: _resource_record_pre_action 08:48:01 INFO - Running main action method: read_buildbot_config 08:48:01 INFO - Using buildbot properties: 08:48:01 INFO - { 08:48:01 INFO - "project": "", 08:48:01 INFO - "product": "firefox", 08:48:01 INFO - "who": "ffxbld@noreply.mozilla.org", 08:48:01 INFO - "installer_path": "public/build/target.tar.bz2", 08:48:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 08:48:01 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:48:01 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 08:48:01 INFO - "stage_platform": "linux64-stylo", 08:48:01 INFO - "basedir": "/builds/slave/test", 08:48:01 INFO - "buildnumber": 115, 08:48:01 INFO - "platform": "ubuntu64_hw_stylo", 08:48:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:48:01 INFO - "slavebuilddir": "test", 08:48:01 INFO - "taskId": "eTX9xZFLTSCdkNJdirrjHA", 08:48:01 INFO - "branch": "mozilla-central", 08:48:01 INFO - "script_repo_revision": "production", 08:48:01 INFO - "revision": "e84acaf49a8f5032864a2602c1c61b68ceb1b773", 08:48:01 INFO - "slavename": "talos-linux64-ix-011", 08:48:01 INFO - "repo_path": "mozilla-central" 08:48:01 INFO - } 08:48:01 INFO - Finding installer, test and symbols from parent task. 08:48:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eTX9xZFLTSCdkNJdirrjHA'}, attempt #1 08:48:01 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eTX9xZFLTSCdkNJdirrjHA'}, attempt #1 08:48:02 INFO - Task dependencies: Aa3_LsyEQ76S4Lrw46uboA 08:48:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA'}, attempt #1 08:48:02 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/target.tar.bz2 08:48:02 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/test_packages.json 08:48:02 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/target.crashreporter-symbols.zip 08:48:02 INFO - Running post-action listener: _resource_record_post_action 08:48:02 INFO - [mozharness: 2017-05-24 15:48:02.477450Z] Finished read-buildbot-config step (success) 08:48:02 INFO - [mozharness: 2017-05-24 15:48:02.477682Z] Running download-and-extract step. 08:48:02 INFO - Running pre-action listener: _resource_record_pre_action 08:48:02 INFO - Running main action method: download_and_extract 08:48:02 INFO - mkdir: /builds/slave/test/build/tests 08:48:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:02 INFO - trying https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/target.test_packages.json 08:48:02 INFO - Downloading https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:48:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:48:03 INFO - Downloaded 986 bytes. 08:48:03 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:48:03 INFO - Using the following test package requirements: 08:48:03 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:48:03 INFO - u'common': [u'target.common.tests.zip'], 08:48:03 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:48:03 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:48:03 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:48:03 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:48:03 INFO - u'mozbase': [u'target.common.tests.zip'], 08:48:03 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:48:03 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:48:03 INFO - u'web-platform': [u'target.common.tests.zip', 08:48:03 INFO - u'target.web-platform.tests.zip'], 08:48:03 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:48:03 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:48:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/target.common.tests.zip 08:48:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:48:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/target.common.tests.zip into memory 08:48:04 INFO - Content-Length response header: 63523779 08:48:04 INFO - Bytes received: 63523779 08:48:15 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:48:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/target.common.tests.zip 08:48:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:48:15 INFO - Fetch https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/target.common.tests.zip into memory 08:48:16 INFO - Content-Length response header: 63523779 08:48:16 INFO - Bytes received: 63523779 08:48:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/target.talos.tests.zip 08:48:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:48:28 INFO - Fetch https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/target.talos.tests.zip into memory 08:48:29 INFO - Content-Length response header: 14411859 08:48:29 INFO - Bytes received: 14411859 08:48:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:29 INFO - trying https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/target.tar.bz2 08:48:29 INFO - Downloading https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:48:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:48:30 INFO - Downloaded 56493580 bytes. 08:48:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/target.tar.bz2 08:48:30 INFO - mkdir: /builds/slave/test/properties 08:48:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:48:30 INFO - Writing to file /builds/slave/test/properties/build_url 08:48:30 INFO - Contents: 08:48:30 INFO - build_url:https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/target.tar.bz2 08:48:30 INFO - Running post-action listener: _resource_record_post_action 08:48:30 INFO - Running post-action listener: set_extra_try_arguments 08:48:30 INFO - [mozharness: 2017-05-24 15:48:30.355381Z] Finished download-and-extract step (success) 08:48:30 INFO - [mozharness: 2017-05-24 15:48:30.355479Z] Running populate-webroot step. 08:48:30 INFO - Running pre-action listener: _resource_record_pre_action 08:48:30 INFO - Running main action method: populate_webroot 08:48:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:48:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:48:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:48:30 INFO - '--tppagecycles', 08:48:30 INFO - '7'], 08:48:30 INFO - 'tests': ['tsvgm']}}, 08:48:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:48:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:48:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:48:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:48:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:48:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:48:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:48:30 INFO - 'talos_options': ['--disable-e10s'], 08:48:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:48:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:48:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:48:30 INFO - 'talos_options': ['--disable-e10s'], 08:48:30 INFO - 'tests': ['damp', 'tps']}, 08:48:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:48:30 INFO - 'tests': ['damp', 'tps']}, 08:48:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:48:30 INFO - 'tests': ['dromaeo_dom']}, 08:48:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:48:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:48:30 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 08:48:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 08:48:30 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 08:48:30 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 08:48:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:48:30 INFO - 'tests': ['a11yr', 08:48:30 INFO - 'ts_paint', 08:48:30 INFO - 'tpaint', 08:48:30 INFO - 'sessionrestore', 08:48:30 INFO - 'sessionrestore_no_auto_restore', 08:48:30 INFO - 'tabpaint']}, 08:48:30 INFO - 'other-e10s': {'tests': ['a11yr', 08:48:30 INFO - 'ts_paint', 08:48:30 INFO - 'tpaint', 08:48:30 INFO - 'sessionrestore', 08:48:30 INFO - 'sessionrestore_no_auto_restore', 08:48:30 INFO - 'tabpaint']}, 08:48:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:48:30 INFO - 'ts_paint', 08:48:30 INFO - 'tpaint', 08:48:30 INFO - 'sessionrestore', 08:48:30 INFO - 'sessionrestore_no_auto_restore', 08:48:30 INFO - 'tabpaint']}, 08:48:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:48:30 INFO - 'ts_paint', 08:48:30 INFO - 'tpaint', 08:48:30 INFO - 'sessionrestore', 08:48:30 INFO - 'sessionrestore_no_auto_restore', 08:48:30 INFO - 'tabpaint']}, 08:48:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:48:30 INFO - 'tests': ['a11yr', 08:48:30 INFO - 'ts_paint', 08:48:30 INFO - 'tpaint', 08:48:30 INFO - 'sessionrestore', 08:48:30 INFO - 'sessionrestore_no_auto_restore', 08:48:30 INFO - 'tabpaint']}, 08:48:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:48:30 INFO - 'tests': ['a11yr', 08:48:30 INFO - 'ts_paint', 08:48:30 INFO - 'tpaint', 08:48:30 INFO - 'sessionrestore', 08:48:30 INFO - 'sessionrestore_no_auto_restore', 08:48:30 INFO - 'tabpaint']}, 08:48:30 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 08:48:30 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 08:48:30 INFO - 'bloom_basic_ref']}, 08:48:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:48:30 INFO - 'tests': ['tsvgx', 08:48:30 INFO - 'tsvgr_opacity', 08:48:30 INFO - 'tart', 08:48:30 INFO - 'tscrollx', 08:48:30 INFO - 'cart', 08:48:30 INFO - 'tsvg_static']}, 08:48:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:48:30 INFO - 'tsvgr_opacity', 08:48:30 INFO - 'tart', 08:48:30 INFO - 'tscrollx', 08:48:30 INFO - 'cart', 08:48:30 INFO - 'tsvg_static']}, 08:48:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:48:30 INFO - 'talos_options': ['--disable-e10s'], 08:48:30 INFO - 'tests': ['tp5o']}, 08:48:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:48:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:48:30 INFO - 'talos_options': ['--disable-e10s', 08:48:30 INFO - '--xperf_path', 08:48:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:30 INFO - 'tests': ['tp5n']}, 08:48:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:48:30 INFO - 'talos_options': ['--xperf_path', 08:48:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:48:30 INFO - 'tests': ['tp5n']}}, 08:48:30 INFO - 'talos.zip': {'path': '', 08:48:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:48:30 INFO - Running post-action listener: _resource_record_post_action 08:48:30 INFO - [mozharness: 2017-05-24 15:48:30.369455Z] Finished populate-webroot step (success) 08:48:30 INFO - [mozharness: 2017-05-24 15:48:30.369544Z] Running create-virtualenv step. 08:48:30 INFO - Running pre-action listener: _resource_record_pre_action 08:48:30 INFO - Running main action method: create_virtualenv 08:48:30 INFO - Creating virtualenv /builds/slave/test/build/venv 08:48:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:48:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:48:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:48:30 INFO - Using real prefix '/usr' 08:48:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:48:30 INFO - Installing distribute.............................................................................................................................................................................................done. 08:48:32 INFO - Installing pip.................done. 08:48:32 INFO - Return code: 0 08:48:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:48:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:48:33 INFO - Reading from file tmpfile_stdout 08:48:33 INFO - Output received: 08:48:33 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:48:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:33 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 0x16ed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a605c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5d7a0>, '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 0x1a5e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5eb30>, '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': '5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:48:33 INFO - Using env: {'DISPLAY': ':0', 08:48:33 INFO - 'HOME': '/home/cltbld', 08:48:33 INFO - 'LANG': 'en_US.UTF-8', 08:48:33 INFO - 'LANGUAGE': 'en_US:en', 08:48:33 INFO - 'LOGNAME': 'cltbld', 08:48:33 INFO - 'MAIL': '/var/mail/cltbld', 08:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:33 INFO - 'MOZ_NO_REMOTE': '1', 08:48:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:33 INFO - 'NO_EM_RESTART': '1', 08:48:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:33 INFO - 'PWD': '/builds/slave/test', 08:48:33 INFO - 'SHELL': '/bin/bash', 08:48:33 INFO - 'SHLVL': '1', 08:48:33 INFO - 'TERM': 'linux', 08:48:33 INFO - 'TMOUT': '86400', 08:48:33 INFO - 'USER': 'cltbld', 08:48:33 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999', 08:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:33 INFO - '_': '/tools/buildbot/bin/python'} 08:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:33 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:48:33 INFO - Cleaning up... 08:48:33 INFO - Return code: 0 08:48:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:33 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 0x16ed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a605c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5d7a0>, '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 0x1a5e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5eb30>, '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': '5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:48:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:48:33 INFO - Using env: {'DISPLAY': ':0', 08:48:33 INFO - 'HOME': '/home/cltbld', 08:48:33 INFO - 'LANG': 'en_US.UTF-8', 08:48:33 INFO - 'LANGUAGE': 'en_US:en', 08:48:33 INFO - 'LOGNAME': 'cltbld', 08:48:33 INFO - 'MAIL': '/var/mail/cltbld', 08:48:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:33 INFO - 'MOZ_NO_REMOTE': '1', 08:48:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:33 INFO - 'NO_EM_RESTART': '1', 08:48:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:33 INFO - 'PWD': '/builds/slave/test', 08:48:33 INFO - 'SHELL': '/bin/bash', 08:48:33 INFO - 'SHLVL': '1', 08:48:33 INFO - 'TERM': 'linux', 08:48:33 INFO - 'TMOUT': '86400', 08:48:33 INFO - 'USER': 'cltbld', 08:48:33 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999', 08:48:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:33 INFO - '_': '/tools/buildbot/bin/python'} 08:48:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:33 INFO - Downloading/unpacking psutil>=3.1.1 08:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:48:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:34 INFO - Installing collected packages: psutil 08:48:34 INFO - Running setup.py install for psutil 08:48:34 INFO - building 'psutil._psutil_linux' extension 08:48:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:48:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:48:35 INFO - building 'psutil._psutil_posix' extension 08:48:35 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:48:35 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:48:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:48:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:48:35 INFO - Successfully installed psutil 08:48:35 INFO - Cleaning up... 08:48:35 INFO - Return code: 0 08:48:35 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16ed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a605c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5d7a0>, '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 0x1a5e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5eb30>, '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': '5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:48:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:48:35 INFO - Using env: {'DISPLAY': ':0', 08:48:35 INFO - 'HOME': '/home/cltbld', 08:48:35 INFO - 'LANG': 'en_US.UTF-8', 08:48:35 INFO - 'LANGUAGE': 'en_US:en', 08:48:35 INFO - 'LOGNAME': 'cltbld', 08:48:35 INFO - 'MAIL': '/var/mail/cltbld', 08:48:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:35 INFO - 'MOZ_NO_REMOTE': '1', 08:48:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:35 INFO - 'NO_EM_RESTART': '1', 08:48:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:35 INFO - 'PWD': '/builds/slave/test', 08:48:35 INFO - 'SHELL': '/bin/bash', 08:48:35 INFO - 'SHLVL': '1', 08:48:35 INFO - 'TERM': 'linux', 08:48:35 INFO - 'TMOUT': '86400', 08:48:35 INFO - 'USER': 'cltbld', 08:48:35 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999', 08:48:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:35 INFO - '_': '/tools/buildbot/bin/python'} 08:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:35 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:48:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:48:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:48:36 INFO - Installing collected packages: mozsystemmonitor 08:48:36 INFO - Running setup.py install for mozsystemmonitor 08:48:36 INFO - Successfully installed mozsystemmonitor 08:48:36 INFO - Cleaning up... 08:48:36 INFO - Return code: 0 08:48:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:36 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 0x16ed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a605c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5d7a0>, '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 0x1a5e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5eb30>, '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': '5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:48:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:48:36 INFO - Using env: {'DISPLAY': ':0', 08:48:36 INFO - 'HOME': '/home/cltbld', 08:48:36 INFO - 'LANG': 'en_US.UTF-8', 08:48:36 INFO - 'LANGUAGE': 'en_US:en', 08:48:36 INFO - 'LOGNAME': 'cltbld', 08:48:36 INFO - 'MAIL': '/var/mail/cltbld', 08:48:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:36 INFO - 'MOZ_NO_REMOTE': '1', 08:48:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:36 INFO - 'NO_EM_RESTART': '1', 08:48:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:36 INFO - 'PWD': '/builds/slave/test', 08:48:36 INFO - 'SHELL': '/bin/bash', 08:48:36 INFO - 'SHLVL': '1', 08:48:36 INFO - 'TERM': 'linux', 08:48:36 INFO - 'TMOUT': '86400', 08:48:36 INFO - 'USER': 'cltbld', 08:48:36 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999', 08:48:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:36 INFO - '_': '/tools/buildbot/bin/python'} 08:48:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:37 INFO - Downloading/unpacking jsonschema==2.5.1 08:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:48:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:38 INFO - Downloading functools32-3.2.3-2.tar.gz 08:48:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:48:38 INFO - warning: no files found matching '*.txt' 08:48:38 INFO - no previously-included directories found matching 'build' 08:48:38 INFO - no previously-included directories found matching 'dist' 08:48:38 INFO - no previously-included directories found matching '.git*' 08:48:38 INFO - Installing collected packages: jsonschema, functools32 08:48:38 INFO - Running setup.py install for functools32 08:48:38 INFO - warning: no files found matching '*.txt' 08:48:38 INFO - no previously-included directories found matching 'build' 08:48:38 INFO - no previously-included directories found matching 'dist' 08:48:38 INFO - no previously-included directories found matching '.git*' 08:48:38 INFO - Successfully installed jsonschema functools32 08:48:38 INFO - Cleaning up... 08:48:38 INFO - Return code: 0 08:48:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:38 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 0x16ed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a605c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5d7a0>, '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 0x1a5e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5eb30>, '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': '5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:48:38 INFO - Using env: {'DISPLAY': ':0', 08:48:38 INFO - 'HOME': '/home/cltbld', 08:48:38 INFO - 'LANG': 'en_US.UTF-8', 08:48:38 INFO - 'LANGUAGE': 'en_US:en', 08:48:38 INFO - 'LOGNAME': 'cltbld', 08:48:38 INFO - 'MAIL': '/var/mail/cltbld', 08:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:38 INFO - 'MOZ_NO_REMOTE': '1', 08:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:38 INFO - 'NO_EM_RESTART': '1', 08:48:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:38 INFO - 'PWD': '/builds/slave/test', 08:48:38 INFO - 'SHELL': '/bin/bash', 08:48:38 INFO - 'SHLVL': '1', 08:48:38 INFO - 'TERM': 'linux', 08:48:38 INFO - 'TMOUT': '86400', 08:48:38 INFO - 'USER': 'cltbld', 08:48:38 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999', 08:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:38 INFO - '_': '/tools/buildbot/bin/python'} 08:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:48:38 INFO - Cleaning up... 08:48:38 INFO - Return code: 0 08:48:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:38 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 0x16ed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a605c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5d7a0>, '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 0x1a5e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5eb30>, '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': '5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:48:38 INFO - Using env: {'DISPLAY': ':0', 08:48:38 INFO - 'HOME': '/home/cltbld', 08:48:38 INFO - 'LANG': 'en_US.UTF-8', 08:48:38 INFO - 'LANGUAGE': 'en_US:en', 08:48:38 INFO - 'LOGNAME': 'cltbld', 08:48:38 INFO - 'MAIL': '/var/mail/cltbld', 08:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:38 INFO - 'MOZ_NO_REMOTE': '1', 08:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:38 INFO - 'NO_EM_RESTART': '1', 08:48:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:38 INFO - 'PWD': '/builds/slave/test', 08:48:38 INFO - 'SHELL': '/bin/bash', 08:48:38 INFO - 'SHLVL': '1', 08:48:38 INFO - 'TERM': 'linux', 08:48:38 INFO - 'TMOUT': '86400', 08:48:38 INFO - 'USER': 'cltbld', 08:48:38 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999', 08:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:38 INFO - '_': '/tools/buildbot/bin/python'} 08:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:38 INFO - Downloading/unpacking blobuploader==1.2.4 08:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:39 INFO - Downloading blobuploader-1.2.4.tar.gz 08:48:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:48:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:48:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:40 INFO - Downloading docopt-0.6.1.tar.gz 08:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:48:40 INFO - Installing collected packages: blobuploader, requests, docopt 08:48:40 INFO - Running setup.py install for blobuploader 08:48:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:48:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:48:40 INFO - Running setup.py install for requests 08:48:40 INFO - Running setup.py install for docopt 08:48:41 INFO - Successfully installed blobuploader requests docopt 08:48:41 INFO - Cleaning up... 08:48:41 INFO - Return code: 0 08:48:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:41 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 0x16ed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a605c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5d7a0>, '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 0x1a5e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5eb30>, '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': '5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:48:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:48:41 INFO - Using env: {'DISPLAY': ':0', 08:48:41 INFO - 'HOME': '/home/cltbld', 08:48:41 INFO - 'LANG': 'en_US.UTF-8', 08:48:41 INFO - 'LANGUAGE': 'en_US:en', 08:48:41 INFO - 'LOGNAME': 'cltbld', 08:48:41 INFO - 'MAIL': '/var/mail/cltbld', 08:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:41 INFO - 'MOZ_NO_REMOTE': '1', 08:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:41 INFO - 'NO_EM_RESTART': '1', 08:48:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:41 INFO - 'PWD': '/builds/slave/test', 08:48:41 INFO - 'SHELL': '/bin/bash', 08:48:41 INFO - 'SHLVL': '1', 08:48:41 INFO - 'TERM': 'linux', 08:48:41 INFO - 'TMOUT': '86400', 08:48:41 INFO - 'USER': 'cltbld', 08:48:41 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999', 08:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:41 INFO - '_': '/tools/buildbot/bin/python'} 08:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:41 INFO - Running setup.py (path:/tmp/pip-NRscBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:41 INFO - Running setup.py (path:/tmp/pip-PrSp9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:41 INFO - Running setup.py (path:/tmp/pip-TtJMl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:41 INFO - Running setup.py (path:/tmp/pip-rBf3xN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:41 INFO - Running setup.py (path:/tmp/pip-0IV3v7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:41 INFO - Running setup.py (path:/tmp/pip-RR8YL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:41 INFO - Running setup.py (path:/tmp/pip-giqLG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:41 INFO - Running setup.py (path:/tmp/pip-WAFX5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:41 INFO - Running setup.py (path:/tmp/pip-_17Hqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:41 INFO - Running setup.py (path:/tmp/pip-fr5N9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:42 INFO - Running setup.py (path:/tmp/pip-qbU7mF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:42 INFO - Running setup.py (path:/tmp/pip-gCKSFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:42 INFO - Running setup.py (path:/tmp/pip-TyIFJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:42 INFO - Running setup.py (path:/tmp/pip-qT34wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:42 INFO - Running setup.py (path:/tmp/pip-45dRpw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:42 INFO - Running setup.py (path:/tmp/pip-1qh5WH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:42 INFO - Running setup.py (path:/tmp/pip-zwzGje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:48:42 INFO - Running setup.py install for manifestparser 08:48:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:48:42 INFO - Running setup.py install for mozcrash 08:48:42 INFO - Running setup.py install for mozdebug 08:48:42 INFO - Running setup.py install for mozdevice 08:48:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:48:42 INFO - Running setup.py install for mozfile 08:48:43 INFO - Running setup.py install for mozhttpd 08:48:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:48:43 INFO - Running setup.py install for mozinfo 08:48:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:48:43 INFO - Running setup.py install for mozInstall 08:48:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:48:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:48:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:48:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:48:43 INFO - Running setup.py install for mozleak 08:48:43 INFO - Running setup.py install for mozlog 08:48:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:48:43 INFO - Running setup.py install for moznetwork 08:48:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:48:43 INFO - Running setup.py install for mozprocess 08:48:43 INFO - Running setup.py install for mozprofile 08:48:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:48:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:48:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:48:43 INFO - Running setup.py install for mozrunner 08:48:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:48:44 INFO - Running setup.py install for mozscreenshot 08:48:44 INFO - Running setup.py install for moztest 08:48:44 INFO - Running setup.py install for mozversion 08:48:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:48:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:48:44 INFO - Cleaning up... 08:48:44 INFO - Return code: 0 08:48:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:44 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 0x16ed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a605c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5d7a0>, '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 0x1a5e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5eb30>, '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': '5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:48:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:48:44 INFO - Using env: {'DISPLAY': ':0', 08:48:44 INFO - 'HOME': '/home/cltbld', 08:48:44 INFO - 'LANG': 'en_US.UTF-8', 08:48:44 INFO - 'LANGUAGE': 'en_US:en', 08:48:44 INFO - 'LOGNAME': 'cltbld', 08:48:44 INFO - 'MAIL': '/var/mail/cltbld', 08:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:44 INFO - 'MOZ_NO_REMOTE': '1', 08:48:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:44 INFO - 'NO_EM_RESTART': '1', 08:48:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:44 INFO - 'PWD': '/builds/slave/test', 08:48:44 INFO - 'SHELL': '/bin/bash', 08:48:44 INFO - 'SHLVL': '1', 08:48:44 INFO - 'TERM': 'linux', 08:48:44 INFO - 'TMOUT': '86400', 08:48:44 INFO - 'USER': 'cltbld', 08:48:44 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999', 08:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:44 INFO - '_': '/tools/buildbot/bin/python'} 08:48:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:48:44 INFO - Running setup.py (path:/tmp/pip-2Np6Oy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:48:44 INFO - Running setup.py (path:/tmp/pip-B2eXEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:48:44 INFO - Running setup.py (path:/tmp/pip-Z0HQi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:48:44 INFO - Running setup.py (path:/tmp/pip-6n9ie9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:48:44 INFO - Running setup.py (path:/tmp/pip-M4F2ho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:48:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:48:44 INFO - Running setup.py (path:/tmp/pip-yAitW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:48:45 INFO - Running setup.py (path:/tmp/pip-agGJnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:48:45 INFO - Running setup.py (path:/tmp/pip-lpU3tR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:48:45 INFO - Running setup.py (path:/tmp/pip-t5_dNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:48:45 INFO - Running setup.py (path:/tmp/pip-XXHtJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:48:45 INFO - Running setup.py (path:/tmp/pip-jbNyP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:48:45 INFO - Running setup.py (path:/tmp/pip-SFEcK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:48:45 INFO - Running setup.py (path:/tmp/pip-NKfHeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:48:45 INFO - Running setup.py (path:/tmp/pip-ZPwL_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:45 INFO - Running setup.py (path:/tmp/pip-kQ4wAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:48:45 INFO - Running setup.py (path:/tmp/pip-mKNBZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:48:45 INFO - Running setup.py (path:/tmp/pip-4w7cbA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:48:45 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:48:45 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:48:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:46 INFO - Downloading blessings-1.6.tar.gz 08:48:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:48:46 INFO - Installing collected packages: blessings 08:48:46 INFO - Running setup.py install for blessings 08:48:47 INFO - Successfully installed blessings 08:48:47 INFO - Cleaning up... 08:48:47 INFO - Return code: 0 08:48:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:48:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:47 INFO - Reading from file tmpfile_stdout 08:48:47 INFO - Current package versions: 08:48:47 INFO - argparse == 1.2.1 08:48:47 INFO - blessings == 1.6 08:48:47 INFO - blobuploader == 1.2.4 08:48:47 INFO - docopt == 0.6.1 08:48:47 INFO - functools32 == 3.2.3-2 08:48:47 INFO - jsonschema == 2.5.1 08:48:47 INFO - manifestparser == 1.1 08:48:47 INFO - mozInstall == 1.12 08:48:47 INFO - mozcrash == 1.0 08:48:47 INFO - mozdebug == 0.1 08:48:47 INFO - mozdevice == 0.50 08:48:47 INFO - mozfile == 1.2 08:48:47 INFO - mozhttpd == 0.7 08:48:47 INFO - mozinfo == 0.9 08:48:47 INFO - mozleak == 0.1 08:48:47 INFO - mozlog == 3.4 08:48:47 INFO - moznetwork == 0.27 08:48:47 INFO - mozprocess == 0.25 08:48:47 INFO - mozprofile == 0.28 08:48:47 INFO - mozrunner == 6.13 08:48:47 INFO - mozscreenshot == 0.1 08:48:47 INFO - mozsystemmonitor == 0.3 08:48:47 INFO - moztest == 0.8 08:48:47 INFO - mozversion == 1.4 08:48:47 INFO - psutil == 3.1.1 08:48:47 INFO - requests == 1.2.3 08:48:47 INFO - wsgiref == 0.1.2 08:48:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:47 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 0x16ed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a605c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5d7a0>, '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 0x1a5e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5eb30>, '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': '5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:48:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:48:47 INFO - Using env: {'DISPLAY': ':0', 08:48:47 INFO - 'HOME': '/home/cltbld', 08:48:47 INFO - 'LANG': 'en_US.UTF-8', 08:48:47 INFO - 'LANGUAGE': 'en_US:en', 08:48:47 INFO - 'LOGNAME': 'cltbld', 08:48:47 INFO - 'MAIL': '/var/mail/cltbld', 08:48:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:47 INFO - 'MOZ_NO_REMOTE': '1', 08:48:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:47 INFO - 'NO_EM_RESTART': '1', 08:48:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:47 INFO - 'PWD': '/builds/slave/test', 08:48:47 INFO - 'SHELL': '/bin/bash', 08:48:47 INFO - 'SHLVL': '1', 08:48:47 INFO - 'TERM': 'linux', 08:48:47 INFO - 'TMOUT': '86400', 08:48:47 INFO - 'USER': 'cltbld', 08:48:47 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999', 08:48:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:47 INFO - '_': '/tools/buildbot/bin/python'} 08:48:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:48:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:48:47 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:48:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:48:48 INFO - Downloading marionette_driver-1.4.0.tar.gz 08:48:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 08:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:48:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 08:48:48 INFO - Installing collected packages: marionette-driver 08:48:48 INFO - Running setup.py install for marionette-driver 08:48:48 INFO - Successfully installed marionette-driver 08:48:48 INFO - Cleaning up... 08:48:48 INFO - Return code: 0 08:48:48 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:48:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:48:48 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 0x16ed1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18baa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a605c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5d7a0>, '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 0x1a5e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5eb30>, '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': '5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:48:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:48:48 INFO - Using env: {'DISPLAY': ':0', 08:48:48 INFO - 'HOME': '/home/cltbld', 08:48:48 INFO - 'LANG': 'en_US.UTF-8', 08:48:48 INFO - 'LANGUAGE': 'en_US:en', 08:48:48 INFO - 'LOGNAME': 'cltbld', 08:48:48 INFO - 'MAIL': '/var/mail/cltbld', 08:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:48:48 INFO - 'MOZ_NO_REMOTE': '1', 08:48:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:48:48 INFO - 'NO_EM_RESTART': '1', 08:48:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:48:48 INFO - 'PWD': '/builds/slave/test', 08:48:48 INFO - 'SHELL': '/bin/bash', 08:48:48 INFO - 'SHLVL': '1', 08:48:48 INFO - 'TERM': 'linux', 08:48:48 INFO - 'TMOUT': '86400', 08:48:48 INFO - 'USER': 'cltbld', 08:48:48 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999', 08:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:48:48 INFO - '_': '/tools/buildbot/bin/python'} 08:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:48:49 INFO - Cleaning up... 08:48:49 INFO - Return code: 0 08:48:49 INFO - Running post-action listener: _resource_record_post_action 08:48:49 INFO - Running post-action listener: _start_resource_monitoring 08:48:49 INFO - Starting resource monitoring. 08:48:49 INFO - [mozharness: 2017-05-24 15:48:49.161238Z] Finished create-virtualenv step (success) 08:48:49 INFO - [mozharness: 2017-05-24 15:48:49.161768Z] Running install step. 08:48:49 INFO - Running pre-action listener: _resource_record_pre_action 08:48:49 INFO - Running main action method: install 08:48:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:48:49 INFO - Reading from file tmpfile_stdout 08:48:49 INFO - Detecting whether we're running mozinstall >=1.0... 08:48:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:48:49 INFO - Reading from file tmpfile_stdout 08:48:49 INFO - Output received: 08:48:49 INFO - Usage: mozinstall [options] installer 08:48:49 INFO - Options: 08:48:49 INFO - -h, --help show this help message and exit 08:48:49 INFO - -d DEST, --destination=DEST 08:48:49 INFO - Directory to install application into. [default: 08:48:49 INFO - "/builds/slave/test"] 08:48:49 INFO - --app=APP Application being installed. [default: firefox] 08:48:49 INFO - mkdir: /builds/slave/test/build/application 08:48:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:49:05 INFO - Reading from file tmpfile_stdout 08:49:05 INFO - Output received: 08:49:05 INFO - /builds/slave/test/build/application/firefox/firefox 08:49:05 INFO - Running post-action listener: _resource_record_post_action 08:49:05 INFO - [mozharness: 2017-05-24 15:49:05.715855Z] Finished install step (success) 08:49:05 INFO - [mozharness: 2017-05-24 15:49:05.716137Z] Running run-tests step. 08:49:05 INFO - Running pre-action listener: _resource_record_pre_action 08:49:05 INFO - Running main action method: run_tests 08:49:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:49:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:49:05 INFO - Python 2.7.3 08:49:05 INFO - Return code: 0 08:49:05 INFO - grabbing minidump binary from tooltool 08:49:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:49:05 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a5d7a0>, '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 0x1a5e6a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a5eb30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:49:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:49:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:49:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:49:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:49:05 INFO - Return code: 0 08:49:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:49:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:49:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:49:05 INFO - ENV: RUST_BACKTRACE is now 1 08:49:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:49:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:49:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:49:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:49:05 INFO - Using env: {'DISPLAY': ':0', 08:49:05 INFO - 'HOME': '/home/cltbld', 08:49:05 INFO - 'LANG': 'en_US.UTF-8', 08:49:05 INFO - 'LANGUAGE': 'en_US:en', 08:49:05 INFO - 'LOGNAME': 'cltbld', 08:49:05 INFO - 'MAIL': '/var/mail/cltbld', 08:49:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:49:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:49:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:49:05 INFO - 'MOZ_NO_REMOTE': '1', 08:49:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:49:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:49:05 INFO - 'NO_EM_RESTART': '1', 08:49:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:49:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:49:05 INFO - 'PWD': '/builds/slave/test', 08:49:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:49:05 INFO - 'RUST_BACKTRACE': '1', 08:49:05 INFO - 'SHELL': '/bin/bash', 08:49:05 INFO - 'SHLVL': '1', 08:49:05 INFO - 'TERM': 'linux', 08:49:05 INFO - 'TMOUT': '86400', 08:49:05 INFO - 'USER': 'cltbld', 08:49:05 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999', 08:49:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:49:05 INFO - '_': '/tools/buildbot/bin/python'} 08:49:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:49:06 INFO - mozversion application_buildid: 20170524150905 08:49:06 INFO - mozversion application_changeset: e84acaf49a8f5032864a2602c1c61b68ceb1b773 08:49:06 INFO - mozversion application_display_name: Nightly 08:49:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:49:06 INFO - mozversion application_name: Firefox 08:49:06 INFO - mozversion application_remotingname: firefox 08:49:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:49:06 INFO - mozversion application_vendor: Mozilla 08:49:06 INFO - mozversion application_version: 55.0a1 08:49:06 INFO - mozversion platform_buildid: 20170524150905 08:49:06 INFO - mozversion platform_changeset: e84acaf49a8f5032864a2602c1c61b68ceb1b773 08:49:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:49:06 INFO - mozversion platform_version: 55.0a1 08:49:06 INFO - using testdate: 1495640946 08:49:06 INFO - actual date: 1495640946 08:49:06 INFO - starting webserver on 'localhost:52185' 08:49:06 INFO - SUITE-START | Running 2 tests 08:49:06 INFO - TEST-START | dromaeo_css 08:49:06 INFO - operating with platform_type : linux_ 08:49:06 INFO - Initialising browser for dromaeo_css test... 08:49:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52185/getInfo.html -profile /tmp/tmpFx5gFe/profile 08:49:06 INFO - TEST-INFO | started process 29575 (/builds/slave/test/build/application/firefox/firefox http://localhost:52185/getInfo.html) 08:49:41 INFO - TEST-INFO | 29575: killed by SIGTERM 08:49:41 INFO - Browser initialized. 08:49:41 INFO - Running cycle 1/1 for dromaeo_css test... 08:49:41 INFO - TEST-INFO | started process 29798 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFx5gFe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:49:53 INFO - PID 29798 | RSS: Main: 176189440 08:49:53 INFO - PID 29798 | 08:52:58 INFO - PID 29798 | Cycle 1(1): loaded http://localhost:52185/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52185/tests/dromaeo/cssquery-ext.html) 08:52:59 INFO - PID 29798 | RSS: Main: 173252608 08:52:59 INFO - PID 29798 | 08:56:01 INFO - PID 29798 | Cycle 1(1): loaded http://localhost:52185/tests/dromaeo/cssquery-ext.html (next: http://localhost:52185/tests/dromaeo/cssquery-jquery.html) 08:56:02 INFO - PID 29798 | RSS: Main: 179671040 08:56:02 INFO - PID 29798 | 08:59:04 INFO - PID 29798 | Cycle 1(1): loaded http://localhost:52185/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52185/tests/dromaeo/cssquery-mootools.html) 08:59:04 INFO - PID 29798 | RSS: Main: 176947200 08:59:04 INFO - PID 29798 | 09:02:06 INFO - PID 29798 | Cycle 1(1): loaded http://localhost:52185/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52185/tests/dromaeo/cssquery-prototype.html) 09:02:07 INFO - PID 29798 | RSS: Main: 183226368 09:02:07 INFO - PID 29798 | 09:05:10 INFO - PID 29798 | Cycle 1(1): loaded http://localhost:52185/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52185/tests/dromaeo/cssquery-yui.html) 09:05:10 INFO - PID 29798 | RSS: Main: 180412416 09:05:10 INFO - PID 29798 | 09:08:12 INFO - PID 29798 | Cycle 1(1): loaded http://localhost:52185/tests/dromaeo/cssquery-yui.html (next: http://localhost:52185/tests/dromaeo/cssquery-dojo.html) 09:08:12 INFO - PID 29798 | RSS: Main: 178278400 09:08:12 INFO - PID 29798 | 09:08:12 INFO - PID 29798 | __start_tp_report 09:08:12 INFO - PID 29798 | _x_x_mozilla_page_load 09:08:12 INFO - PID 29798 | _x_x_mozilla_page_load_details 09:08:12 INFO - PID 29798 | |i|pagename|runs| 09:08:12 INFO - PID 29798 | |0;dojo.html;2750.669919609647;2757.993332433662;2795.9860200698995;2811.4939310924024;2820.097568777991;5216.400113986892;5313.442088580697;5333.626646134772;5341.172118321666;5371.731413429327;5275.709835959021;5288;5323.707196104213;5384.1923711443305;5401.27082843816;4526.345156666389;4694.366260554824;4711.222648263032;4769.260764581495;4784.5693887550115;4802.03959208158;4805.831795887145;4808.975955120202;4844.491328410519;4853.150698627744;4668.019715859639;4680.438347398334;4708.223143181371;4729.125111854283;4736.123817093814;4767.237242041257;4770.0698363819065;4770.928436073462;4784.42586889572;4814.422269327703;4685.812567497296;4715.292706094079;4737.715737055788;4742.644301677354;4759.452662943771;5232.816851410221;5282.867928301823;5302.575793936476;5315.468453154692;5346.331708536433;5716.942830571724;5736.340320863071;5817.447342502455;5832.475077243069;5834.0373838317055;5784.07454807233;5784.537237021028;5786.855328616818;5789.45000224978;5834.445727655866;5350.464953504618;5364.409914909357;5365.678059316453;5367.409584945653;5368.785248590091;5846.853828654318;5923.111533269957;5925.081612350006;5932.872754176693;5991.670458124758;5616.887662246732;5659.575531835047;5664.291963504562;5665.2635157430095;5702.173184888168;5592.189132575835;5680.630759000652;5718.857028574235;5737.282839645044;5745.482906538348;5572.777088916398;5611.410801865745;5664.235328230719;5766.221560089334;5788.855278617984;5699.059655156852;5772.62477938941;5781.739821708034;5781.768729250867;5795;4741.502142275081;4746.715197088117;4748.572628463455;4754.7147171169845;4776.832810851603;4001.6198461146146;4085.22380747657;4085.346344584852;4086.693497987663;4094.754314741125;4811.831585894547;4839.2983017462275;4899.363082799285;4913.1893237616105;4922.138625740481;5786.189933409326;5801.216835727208;5806.4193580641595;5807.651540907559;5813.82558523245;4771.451283102488;4786.736729479912;4797.56821886032;4852.0295940811275;4854.344663470457;4978.726170060609;4980.327655766498;5036.874078148002;5090.4655011223285;5094.643374963717;5438.510534051954;5439.265699130567;5441.102218133963;5446.591505637172;5454.590905682169;5721.399253078367;5772.076467765138;5805.506531944663;5829.38791426911;5831;5374.247605335335;5417.674939503642;5443.755031023693;5443.945560544344;5447.918281225706;5732.05421105513;5741.770329186953;5749.8275051748515;5752.223449834386;5759.078547432391;5715.714214289185;5841.4450627190345;5843;5844.3571207168025;5862.267216597926;5591.832245032656;5596.384397716167;5682.602217844711;5684.033714268501;5687.857803554944;5606.775728970795;5609.1305847593685;5610.438956104357;5615.971920140537;5645.209670646031;5517.724113794214;5531.529819965348;5549.805756798654;5554.805581804618;5557.44425557441;5580.330360356783;5616.634918730269;5659;5666.914996275142;5673.120666296731;5495.862603434946;5501.367342755474;5515.145152501369;5515.4760297771645;5515.862103447446 09:08:12 INFO - PID 29798 | |1;ext.html;661.8180000499862;711.6726305899286;733.1349008170358;1048.617254702034;1071.0467683761449;29653.110406687807;33362.66637333629;33540.49689254657;33544.66455335449;33603.66396336036;35847.82076089616;36062.81968590154;36274.63725362746;36274.8186259069;36368.09079773007;6436.163298771153;6902.413294869942;6998.405135563483;7000.719971201146;7012.26371231021;6610.537262391635;6641.236257830339;6700.932990670104;6702.966485167567;6720.59676419414;6658.733650653992;6740.797776066725;6755.864882702367;6762.425193858528;6764.7970560883;6688.93311066888;6715.093462382565;6717.6977036033495;6736.966315168393;6737.056812046293;6725.361090696376;6758.729650813962;6765.154355705537;6770.356816102511;6785.864282714368;32172.517412238834;32315.353692926245;32329.353412931843;32374.6762532374;32452;3002.519596864513;3036.7266945974748;3044.436779195834;3056.66376698563;3056.770742194322;24860.50278994428;24869.875650621812;24918.37704057395;24935.625965610532;24945.750542494523;2915.052607902419;2926.692697266799;2931.4723349797027;2940.794144409892;2956.068838315945;142975;144151;144309.2784536081;145437;146347;38438.807805960794;38597.80701096533;38669.22661546753;38678.22643547113;38783.806080969414;39841.800790996436;39916.806655467495;39946;39993.400098998536;40027.79986100051;11076.11391088711;11076.169287303484;11143.554257829757;11206.607768728056;11220.831687524693;8765.780855478664;8848.336374771918;8858.202761751345;8858.424202426822;8860.424072435271;12606.306653134166;12642.873571264354;12707.174033687781;12746.171498852545;12898.161619494704;5111.904119311064;5117.565006974449;5174.767135478913;5332.226827110125;5339.652922560022;863.6329559937002;879.208712159062;893.2228960804142;894.3158483759929;932.421898422982;20186.89545876839;21077;21123.838188899757;21216.469588260417;21375.893120534296;957.2055194188806;962.7833737409027;963.8987906269881;970.3013830042358;988.5008070924138;10438.582456701646;11412.087033037336;11500.137489688139;14343.354549045318;14872.851271487363;172333;173224;173408.13295933438;174142;175735;43829;44219.33670994938;44369.778151109036;44471.33293000607;44697.55302446999;1160.651804458676;1208.2025862930423;1209.2683926224684;1212.3332167308122;1214.180428210954;23236.651450228597;23660.52678946377;25135.74864251407;25166.24501264965;25189.49621007533;29956;29981.100566983027;30195.396092078474;30212.395752085275;30227.395452091274;152434.23782881457;152543;153532.23233883758;153666;154419;28111.297217569725;28380.57429138606;28494;28581.42837143287;28653.14040578786;35002.12494687551;35332.11669708175;35509.82245088758;35635.46546801748;35675.82162089277;26086.60870086988;26602.866985664947;26643.200703978913;26919.192424227305;27354.5896811544;26323.46232421613;26555;27476.862615686794;27504.862475687492;28049.579256310764;30164.681884992195;30249.697503024687;30281.24296892595;30306.696933030387;30376.696233037386;25823.741762582886;25835.354116147246;26354;26413.60379594269;27458.313542160806;20546.507093793793;21301.46746331354;21308.590625499844;21546.569068618854;21569 09:08:12 INFO - PID 29798 | |2;jquery.html;418.30791099709484;422.39386480400606;430.38240125420015;439.4024127187025;441.64006334837103;14121.717565648682;14844.257787110655;17341.21964511597;17952.82047179528;18023.549411264725;16363.181840907937;16438;16655.66688666226;16667.91666041671;16791.748123778154;5470.097433923398;5616.185653080301;5666.688332141731;5669.9433005670035;5674.744636491368;5363.088274993261;5521.834344969658;5542.7782888684405;5552.278203833496;5552.611317207797;5190.2474141249495;5427.375851777037;5452.945470545284;5512.862178445531;5526.143447765583;5263.868403289929;5277.050130976423;5294.126469132589;5296.073187192226;5311.282976798121;4804.111239420718;4807.134715751164;4834.274858771178;4948.87627809304;4983.227599722049;21921.671174932388;22265.77734222653;22329.553408931894;22389.44026399337;22581.435464113365;1535.9232038398036;1537.4311504743316;1542.3290868472138;1561;1623.3506597361031;14144;14220.360083796253;14568;14624.195669238188;14626.195559244237;2038.2458490358515;2050.4156315450027;2096.5911647228795;2107.4942013916702;2116.968245476319;90247;92756;93215;97416.51291743567;98202.01797982;10982.286151400134;11298.943505282421;11342.943285283522;11386.658400248005;11458.140639452075;15864.73082153448;15917.840821591635;15926.681466370608;15940.681186376207;16032.75950860738;6670.166229221348;6782.406134558375;7028.753993610199;7077.115360579927;7251.7099316027825;5974.85062873423;6057.545684073712;6118.908216376758;6126.142340072393;6203.96898015507;6943.79168624942;6976.476764242702;7031.367176954099;7038.507304488637;7110.466714996396;2001.319551352547;2001.7197592337084;2052.835773138145;2060.7424071991;2211.3918672364907;829.9377546684022;862.1034124510564;879.0857508191409;887.7691800131882;894.9507777072323;16933.32266709318;16977.575560611083;16991.150442478072;17272.65454690899;17591.73612395815;866.8916385451819;871.1201686296886;875.1161327059589;875.3216257400566;893.2273583350355;9168.220701240469;9210.861837072316;9470.763230919281;9478.857817132748;9487.47818869955;341698;347868;348661;348685;348711;74057.6297118511;75361;76313.23686763173;76567.61716191383;78373;1057.3867157048894;1067.0769784136821;1099.6700989703056;1103.475848971732;1107.684309971654;17472.91263543674;17622.559436014202;18103.275868965622;18328.725069123706;18836.623267534298;39516;39676.404853927794;40176.19207135744;40550.39174412445;40880.79559602183;48338.75830620824;48377.516224838706;49129.50870491249;49957;50527.49472505228;8093.838123237385;8347.12355202695;8576.485410875368;8678.613097196898;8755.693550725695;12473.563425280072;12496.562620308245;12712.555060572835;12721.045921555735;12894.355282235663;10446.895531044593;10686.89313106859;10913.618023369145;11182.832257515982;11811.350375729073;10508.42203678805;10847.349159050167;10896.346219226873;11028.613998510014;11305.547778088785;10745.462726863469;11336.603218887629;11513.194076414906;11542.19204655666;12169.878301216875;8199.877001845096;8315.708950186714;8368.958155209428;8377.413581049268;8406.537640429835;10801.67594972152;10823.80938096793;10908.781824363627;11043.226974111734;11090.611828585961 09:08:12 INFO - PID 29798 | |3;mootools.html;1272.4782839035995;1307.3267267357307;1325.933703314834;1328.3690247132613;1346.0779366134195;9950.303478756481;10094.848577271347;10408.167346612272;10425.53085111169;10636.361818290909;10252.53863576139;10459.895401046006;10469.214808889326;10478.10936070433;10515.894841051588;2196.374033400485;2225.18780645065;2226.265332440291;2229.698990636268;2250.088714070804;2107.620628286908;2117.375374264588;2122.129926730041;2132.8720276783365;2148.7636360000465;2038.704387863759;2052.5586998795256;2059.640637179462;2059.691046343053;2064.0505367530877;2061.762897266811;2067.824234940032;2082.552251265985;2083.14591017682;2084.8749075055543;1920.0783623860486;2002.3892712722613;2028.8782673039666;2059.4542446251753;2063.0716177719937;10257.487125643687;10289.742756431075;10330;10330.89669103307;10349.637762678345;5164.870878228036;5350.49170328822;5403.51368376844;5403.78384864605;5403.8108666196495;3170.6036745406823;3285.063756829316;3338.132085657722;3355.3624811285777;3356.7650264481495;1108.4457771114444;1122.2480937771713;1145.8682251541013;1166.0729719872722;1184.0231808757724;14811.925940370336;14995.850041499554;15006.924965375103;15017.474388396464;15050.32273547682;4661.766911654404;4731.834385796549;4869;4927.127691477287;4936;10230.437325947145;10265.846012309821;10302.587896484056;10309.84535231972;10343.63797267092;4992;5129.769160387791;5132.409772876167;5140.203268493389;5155.61332900034;4709.340692303081;4802.255650374198;4809.470958194595;4811.422629284439;4813.205821039559;3734.79458629778;3833.9808300958316;3842.538895332578;3860.864869729546;3892.2215556888737;1097.7145942054963;1101.5869049106584;1104.7072525780675;1105.5854054729477;1121.1759356872692;724.8658998085372;750.0923882102717;751.9849603008018;758.8785794273;765.6860687118254;5739.16782066598;5746.827595172152;5819.709014549256;5889.469947704727;5950.256217972754;821.1542111625035;830.1449507007671;835.2983493865182;843.8987321521457;849.3332733803934;3675.650813172744;3997.200559888034;4004.619561141687;4101.200265948171;4265.274903266452;13354.93322533381;13474;13606.455741770218;13618.863811361958;13672.794908076386;13083.280419576824;13100.886424653821;13378.13042152257;13495.59513214605;13496.39266233022;7537.2085930976455;7562.621868906643;7679.232076792276;7733.110692270348;7747.418943579254;6414.326495717883;6536.542442029012;6562.901556476561;6706.93293067063;6762.763303284361;11813.350265735124;12185.268883866996;12201.51193952232;12219.45012474423;12281.69295767613;12242.510299587917;12277.815832762695;12300.07749418815;12475.812862806884;12494.937525312314;8983.146601072887;9355;9510.476923768982;9529.094736000068;9535.952320238355;9511.429314241168;9702.078302561245;9703.07820757027;9719;9725.6596019139;7851.882221766564;7966.123726389977;8171.713990010321;8285.917140828757;8397.328213742763;7622;7922.683092676229;8015.198480151938;8024.719134830253;8175.7138500152205;7419.29516695913;7537.472376933562;7551.433642476726;7552.509086909334;7560.054993125859;5574.108142697149;5648.4633959773755;5703.971480142739;5898.20374249488;5994.520438365008;5745.070014292824;5761.337446193741;5774.769009239583;5804.854878628068;5963.73163207648 09:08:12 INFO - PID 29798 | |4;prototype.html;385.8032403474229;388.3185010306911;388.45616137407626;392.24688597892043;395.5984675554311;5452.536534394581;5485.835424937259;5493.368262649797;5495.258140151083;5589.916151257735;5403.459654034595;5475.780968761244;5493.313335833011;5518.709735459779;5543.113101903697;4219.430376899126;4366.083122544277;4378.759168245745;4394.780260986954;4396.054848207635;4365.148795984785;4386.6929314947965;4399.824007039714;4410.235905637738;4421.9336709949375;4332.97833510832;4368.868933931971;4384.254676704968;4407.2948328267485;4418.911621767563;4310.676699247553;4360.803763830635;4376.124775044972;4399.164158809832;4400.44994375703;3966.484357033596;3983.342748446503;3996.220736956295;4013.4581831452674;4020.19596080785;5412.269343638598;5458.181272809071;5458.945410545924;5461.808836690697;5463.262459567947;5100.285959965608;5156.948430515685;5217.947820521784;5224.111900976843;5228.503292187274;5887.676177810219;5888.970555147197;5918.970405147989;5928.28860536734;5942.019566771478;4494.662900282492;4503.369528266046;4503.729776213405;4506.481754598198;4519.751413672247;5885.764569417218;5971.940280597225;6048.60684055535;6101.101976561143;6174.722137503778;4341.8480353188115;4352.934705979413;4384.780760962003;4390.560943905648;4399.64802815774;4445;4446.955530444654;4449.844255451044;4450.577195166454;4469.08383781324;4961.231009193581;4999.875003124951;5021.221710634857;5035.269885866529;5189.221616757441;5877.706114694333;5906.114082887601;5918.7928422505;5920.851978700481;5943.732532036069;1622.9350825966828;1647.604574902015;1649.736042233237;1652.8760342974324;1659.556186118085;1161.2916121166081;1178.6640807369859;1199.1066655341826;1206.6681662542871;1209.5524655877382;5006.899862002812;5007.6494645375205;5008.974955125274;5024.949750502448;5033.5721463676;6002.4897883679505;6006.879862402728;6029.60807547508;6040.395960404012;6049.425304596057;4852.660313778002;4992.15133427311;5011.323471331397;5019.322391477177;5026.396832380065;3183.2678483948357;3200.871965121369;3203.6796320367775;3215.6784321567657;3228.3059142284524;5496.80761173357;5618;5642.520385767256;5654.042170480598;5694.9430505695245;6193.938060619426;6235.75056997715;6246.75012999484;6250.468710159596;6288.434040936338;5592.133219351007;5617.831465056055;5635.633034125677;5644;5667.858303542444;5936.821895343147;5945.464908158287;6013.128096425906;6045.667488288186;6077.511009802627;5879.795076846182;5917.852053698692;5955.4391611607425;5964.343922168471;5966.3735307793795;5485.546330222414;5585.3297604287745;5588.441155884541;5650.107214083164;5658.943410565842;4142.751434913915;4159.584041595937;4172.937405938853;4177.874663760092;4180.393842892703;5930.169776231245;6092.268927728701;6141.078838174131;6168.475679567107;6170.568060235741;5845.561582881216;5856.677882716492;5869.148973398748;5888.440598143169;5905.940940590539;5840.948629246776;5881.117832325185;5893.145493903275;5905.232319798399;5920.79277225295;5639.436056394327;5676.508946997485;5731.168980497721;5786.797462088806;5790.1893734877995;5890.764369425175;5902.557308201816;5912.763489460373;5924.6149000314845;5930.406959304035;5585.273914391103;5684.886302273849;5710;5720.599558030898;5743.712814359349 09:08:12 INFO - PID 29798 | |5;yui.html;672.0222076878143;675.689182975831;694.2086021934994;696.7143471176819;701.7228194863028;12928.806067908978;13398.531051413203;13440.865591344096;14845.406183752664;15262.160581168031;16252.268647910843;16464.094474803882;16475.340986360563;16544.50366489007;16552.420665276717;855.7047818502607;867.9913200868006;868.4572142410993;868.956552172392;870.708312715238;874.7463235661683;877.3639111644039;877.8376000439939;878.8857448531681;880.5949263338872;915.945043297401;921.0283151275402;922.1470140120396;922.5110691333604;923.501309292981;921.1019256225161;921.6313474610176;922.4649703172144;924.1405492891608;924.6671198368582;627.7991042866284;658.4633523678187;663.3863676099637;666.4601672645173;675.8918573028341;14285.285735713172;14290.214038227894;14420.278986050656;14482.348294326675;14506.92746536271;15214.543563693107;15553.533393998197;15668.451604193799;16145.757813632805;16305.91847040769;12236.81644775329;12878.29169395683;13060;13081.280529570964;13089.607311780663;3002.8498575071158;3024.8638811253545;3033.8634761435787;3035.6357237131465;3035.893743718981;77214;79271;79534.99999999942;79693.20306796915;79797.60101199515;11954.820677689842;12117.818232726517;12431.62705118848;12527.123101382816;12552.43514041852;22065.889670551867;22244;22456.32631021072;22498.66252006221;22561.09755609757;5905.379935106838;5965.970170149121;6021.879562408727;6052.697365131726;6138.508919286446;2826.632537770118;2884.769218462518;2892.464893994618;2894.1028281232884;2895.8407287599384;3611.656892595199;3671.2473942841652;3688;3701.648343407372;3702.0559757261726;709.9787006389816;730.9159446663701;735.7608777147342;736.9447291453055;738.2211766586303;599.1372423709844;606.6269244414741;608.3308360803081;622.9003359462464;630.4578062865932;10130.949345253373;10263.692089237335;10703.73240668974;10836.67489975302;11010.724731881606;566.0631654611624;575.2464271803867;577.4946921443736;582.7931084464954;585.2917969257246;4566.178087944136;4636;4677.462091859412;4679.789409476582;4731.243001119804;83188.58405708054;85602;87397.56301218453;89403.10596894078;91239;76958;77072;77695.61152194203;77784;78408.60795695985;66651;67716;69131.65434172898;71209.795559201;72032.63983680047;9390.154886060287;9443.716688499357;9476.147146756824;9594.952025239829;9825.312228144247;26821.597676035264;31052.68947310498;31141.377172456876;31160.065198044096;31342.05973820789;51107.74446127894;51528;51709.7414512925;51862.481375185766;54509;14634;14735;14794.926025369805;15018.249087545797;15033.774493382827;16845.326186952385;16958.406455773988;17126.314947401963;17136.828631713524;17309.480715578553;14759.114453132846;14924.925375373054;15045.924770376078;15111.093334399971;15476.303566339317;14738.11571305725;15188.544343669708;15190.240487975778;15283.694326113193;15351.84648153549;14095.647608809451;14334.928325358307;14688.926555367154;14836.10983341003;15071.321790519673;9657.661981830603;9762;9882.209423246266;9892.406455612687;9907.356021858555;11204.66386008421;11617.825732613848;11897.46461409256;12083.456244469196;12202.14584979043 09:08:12 INFO - PID 29798 | __end_tp_report 09:08:12 INFO - PID 29798 | __start_cc_report 09:08:12 INFO - PID 29798 | _x_x_mozilla_cycle_collect,325 09:08:12 INFO - PID 29798 | __end_cc_report 09:08:12 INFO - PID 29798 | __startTimestamp1495642092789__endTimestamp 09:08:12 INFO - PID 29798 | 09:08:12 INFO - PID 29798 | ------- Summary: start ------- 09:08:12 INFO - PID 29798 | Number of tests: 6 09:08:12 INFO - PID 29798 | 09:08:12 INFO - PID 29798 | [#0] dojo.html Cycles:165 Average:5263.04 Median:5446.59 stddev:632.64 (11.6%) stddev-sans-first:603.10 09:08:12 INFO - PID 29798 | Values: 2750.7 2758.0 2796.0 2811.5 2820.1 5216.4 5313.4 5333.6 5341.2 5371.7 5275.7 5288.0 5323.7 5384.2 5401.3 4526.3 4694.4 4711.2 4769.3 4784.6 4802.0 4805.8 4809.0 4844.5 4853.2 4668.0 4680.4 4708.2 4729.1 4736.1 4767.2 4770.1 4770.9 4784.4 4814.4 4685.8 4715.3 4737.7 4742.6 4759.5 5232.8 5282.9 5302.6 5315.5 5346.3 5716.9 5736.3 5817.4 5832.5 5834.0 5784.1 5784.5 5786.9 5789.5 5834.4 5350.5 5364.4 5365.7 5367.4 5368.8 5846.9 5923.1 5925.1 5932.9 5991.7 5616.9 5659.6 5664.3 5665.3 5702.2 5592.2 5680.6 5718.9 5737.3 5745.5 5572.8 5611.4 5664.2 5766.2 5788.9 5699.1 5772.6 5781.7 5781.8 5795.0 4741.5 4746.7 4748.6 4754.7 4776.8 4001.6 4085.2 4085.3 4086.7 4094.8 4811.8 4839.3 4899.4 4913.2 4922.1 5786.2 5801.2 5806.4 5807.7 5813.8 4771.5 4786.7 4797.6 4852.0 4854.3 4978.7 4980.3 5036.9 5090.5 5094.6 5438.5 5439.3 5441.1 5446.6 5454.6 5721.4 5772.1 5805.5 5829.4 5831.0 5374.2 5417.7 5443.8 5443.9 5447.9 5732.1 5741.8 5749.8 5752.2 5759.1 5715.7 5841.4 5843.0 5844.4 5862.3 5591.8 5596.4 5682.6 5684.0 5687.9 5606.8 5609.1 5610.4 5616.0 5645.2 5517.7 5531.5 5549.8 5554.8 5557.4 5580.3 5616.6 5659.0 5666.9 5673.1 5495.9 5501.4 5515.1 5515.5 5515.9 09:08:12 INFO - PID 29798 | 09:08:12 INFO - PID 29798 | [#1] ext.html Cycles:180 Average:30169.91 Median:30265.47 stddev:40695.93 (134.5%) stddev-sans-first:40749.77 09:08:12 INFO - PID 29798 | Values: 661.8 711.7 733.1 1048.6 1071.0 29653.1 33362.7 33540.5 33544.7 33603.7 35847.8 36062.8 36274.6 36274.8 36368.1 6436.2 6902.4 6998.4 7000.7 7012.3 6610.5 6641.2 6700.9 6703.0 6720.6 6658.7 6740.8 6755.9 6762.4 6764.8 6688.9 6715.1 6717.7 6737.0 6737.1 6725.4 6758.7 6765.2 6770.4 6785.9 32172.5 32315.4 32329.4 32374.7 32452.0 3002.5 3036.7 3044.4 3056.7 3056.8 24860.5 24869.9 24918.4 24935.6 24945.8 2915.1 2926.7 2931.5 2940.8 2956.1 142975.0 144151.0 144309.3 145437.0 146347.0 38438.8 38597.8 38669.2 38678.2 38783.8 39841.8 39916.8 39946.0 39993.4 40027.8 11076.1 11076.2 11143.6 11206.6 11220.8 8765.8 8848.3 8858.2 8858.4 8860.4 12606.3 12642.9 12707.2 12746.2 12898.2 5111.9 5117.6 5174.8 5332.2 5339.7 863.6 879.2 893.2 894.3 932.4 20186.9 21077.0 21123.8 21216.5 21375.9 957.2 962.8 963.9 970.3 988.5 10438.6 11412.1 11500.1 14343.4 14872.9 172333.0 173224.0 173408.1 174142.0 175735.0 43829.0 44219.3 44369.8 44471.3 44697.6 1160.7 1208.2 1209.3 1212.3 1214.2 23236.7 23660.5 25135.7 25166.2 25189.5 29956.0 29981.1 30195.4 30212.4 30227.4 152434.2 152543.0 153532.2 153666.0 154419.0 28111.3 28380.6 28494.0 28581.4 28653.1 35002.1 35332.1 35509.8 35635.5 35675.8 26086.6 26602.9 26643.2 26919.2 27354.6 26323.5 26555.0 27476.9 27504.9 28049.6 30164.7 30249.7 30281.2 30306.7 30376.7 25823.7 25835.4 26354.0 26413.6 27458.3 20546.5 21301.5 21308.6 21546.6 21569.0 09:08:12 INFO - PID 29798 | 09:08:12 INFO - PID 29798 | [#2] jquery.html Cycles:180 Average:24394.81 Median:39596.20 stddev:58199.97 (147.0%) stddev-sans-first:58335.39 09:08:12 INFO - PID 29798 | Values: 418.3 422.4 430.4 439.4 441.6 14121.7 14844.3 17341.2 17952.8 18023.5 16363.2 16438.0 16655.7 16667.9 16791.7 5470.1 5616.2 5666.7 5669.9 5674.7 5363.1 5521.8 5542.8 5552.3 5552.6 5190.2 5427.4 5452.9 5512.9 5526.1 5263.9 5277.1 5294.1 5296.1 5311.3 4804.1 4807.1 4834.3 4948.9 4983.2 21921.7 22265.8 22329.6 22389.4 22581.4 1535.9 1537.4 1542.3 1561.0 1623.4 14144.0 14220.4 14568.0 14624.2 14626.2 2038.2 2050.4 2096.6 2107.5 2117.0 90247.0 92756.0 93215.0 97416.5 98202.0 10982.3 11298.9 11342.9 11386.7 11458.1 15864.7 15917.8 15926.7 15940.7 16032.8 6670.2 6782.4 7028.8 7077.1 7251.7 5974.9 6057.5 6118.9 6126.1 6204.0 6943.8 6976.5 7031.4 7038.5 7110.5 2001.3 2001.7 2052.8 2060.7 2211.4 829.9 862.1 879.1 887.8 895.0 16933.3 16977.6 16991.2 17272.7 17591.7 866.9 871.1 875.1 875.3 893.2 9168.2 9210.9 9470.8 9478.9 9487.5 341698.0 347868.0 348661.0 348685.0 348711.0 74057.6 75361.0 76313.2 76567.6 78373.0 1057.4 1067.1 1099.7 1103.5 1107.7 17472.9 17622.6 18103.3 18328.7 18836.6 39516.0 39676.4 40176.2 40550.4 40880.8 48338.8 48377.5 49129.5 49957.0 50527.5 8093.8 8347.1 8576.5 8678.6 8755.7 12473.6 12496.6 12712.6 12721.0 12894.4 10446.9 10686.9 10913.6 11182.8 11811.4 10508.4 10847.3 10896.3 11028.6 11305.5 10745.5 11336.6 11513.2 11542.2 12169.9 8199.9 8315.7 8369.0 8377.4 8406.5 10801.7 10823.8 10908.8 11043.2 11090.6 09:08:12 INFO - PID 29798 | 09:08:12 INFO - PID 29798 | [#3] mootools.html Cycles:180 Average:6357.00 Median:3784.39 stddev:4089.55 (108.1%) stddev-sans-first:4083.18 09:08:12 INFO - PID 29798 | Values: 1272.5 1307.3 1325.9 1328.4 1346.1 9950.3 10094.8 10408.2 10425.5 10636.4 10252.5 10459.9 10469.2 10478.1 10515.9 2196.4 2225.2 2226.3 2229.7 2250.1 2107.6 2117.4 2122.1 2132.9 2148.8 2038.7 2052.6 2059.6 2059.7 2064.1 2061.8 2067.8 2082.6 2083.1 2084.9 1920.1 2002.4 2028.9 2059.5 2063.1 10257.5 10289.7 10330.0 10330.9 10349.6 5164.9 5350.5 5403.5 5403.8 5403.8 3170.6 3285.1 3338.1 3355.4 3356.8 1108.4 1122.2 1145.9 1166.1 1184.0 14811.9 14995.9 15006.9 15017.5 15050.3 4661.8 4731.8 4869.0 4927.1 4936.0 10230.4 10265.8 10302.6 10309.8 10343.6 4992.0 5129.8 5132.4 5140.2 5155.6 4709.3 4802.3 4809.5 4811.4 4813.2 3734.8 3834.0 3842.5 3860.9 3892.2 1097.7 1101.6 1104.7 1105.6 1121.2 724.9 750.1 752.0 758.9 765.7 5739.2 5746.8 5819.7 5889.5 5950.3 821.2 830.1 835.3 843.9 849.3 3675.7 3997.2 4004.6 4101.2 4265.3 13354.9 13474.0 13606.5 13618.9 13672.8 13083.3 13100.9 13378.1 13495.6 13496.4 7537.2 7562.6 7679.2 7733.1 7747.4 6414.3 6536.5 6562.9 6706.9 6762.8 11813.4 12185.3 12201.5 12219.5 12281.7 12242.5 12277.8 12300.1 12475.8 12494.9 8983.1 9355.0 9510.5 9529.1 9536.0 9511.4 9702.1 9703.1 9719.0 9725.7 7851.9 7966.1 8171.7 8285.9 8397.3 7622.0 7922.7 8015.2 8024.7 8175.7 7419.3 7537.5 7551.4 7552.5 7560.1 5574.1 5648.5 5704.0 5898.2 5994.5 5745.1 5761.3 5774.8 5804.9 5963.7 09:08:12 INFO - PID 29798 | 09:08:12 INFO - PID 29798 | [#4] prototype.html Cycles:180 Average:4894.44 Median:5462.54 stddev:1375.96 (25.2%) stddev-sans-first:1337.56 09:08:12 INFO - PID 29798 | Values: 385.8 388.3 388.5 392.2 395.6 5452.5 5485.8 5493.4 5495.3 5589.9 5403.5 5475.8 5493.3 5518.7 5543.1 4219.4 4366.1 4378.8 4394.8 4396.1 4365.1 4386.7 4399.8 4410.2 4421.9 4333.0 4368.9 4384.3 4407.3 4418.9 4310.7 4360.8 4376.1 4399.2 4400.4 3966.5 3983.3 3996.2 4013.5 4020.2 5412.3 5458.2 5458.9 5461.8 5463.3 5100.3 5156.9 5217.9 5224.1 5228.5 5887.7 5889.0 5919.0 5928.3 5942.0 4494.7 4503.4 4503.7 4506.5 4519.8 5885.8 5971.9 6048.6 6101.1 6174.7 4341.8 4352.9 4384.8 4390.6 4399.6 4445.0 4447.0 4449.8 4450.6 4469.1 4961.2 4999.9 5021.2 5035.3 5189.2 5877.7 5906.1 5918.8 5920.9 5943.7 1622.9 1647.6 1649.7 1652.9 1659.6 1161.3 1178.7 1199.1 1206.7 1209.6 5006.9 5007.6 5009.0 5024.9 5033.6 6002.5 6006.9 6029.6 6040.4 6049.4 4852.7 4992.2 5011.3 5019.3 5026.4 3183.3 3200.9 3203.7 3215.7 3228.3 5496.8 5618.0 5642.5 5654.0 5694.9 6193.9 6235.8 6246.8 6250.5 6288.4 5592.1 5617.8 5635.6 5644.0 5667.9 5936.8 5945.5 6013.1 6045.7 6077.5 5879.8 5917.9 5955.4 5964.3 5966.4 5485.5 5585.3 5588.4 5650.1 5658.9 4142.8 4159.6 4172.9 4177.9 4180.4 5930.2 6092.3 6141.1 6168.5 6170.6 5845.6 5856.7 5869.1 5888.4 5905.9 5840.9 5881.1 5893.1 5905.2 5920.8 5639.4 5676.5 5731.2 5786.8 5790.2 5890.8 5902.6 5912.8 5924.6 5930.4 5585.3 5684.9 5710.0 5720.6 5743.7 09:08:12 INFO - PID 29798 | 09:08:12 INFO - PID 29798 | [#5] yui.html Cycles:180 Average:18044.76 Median:4601.09 stddev:23699.59 (515.1%) stddev-sans-first:23730.17 09:08:12 INFO - PID 29798 | Values: 672.0 675.7 694.2 696.7 701.7 12928.8 13398.5 13440.9 14845.4 15262.2 16252.3 16464.1 16475.3 16544.5 16552.4 855.7 868.0 868.5 869.0 870.7 874.7 877.4 877.8 878.9 880.6 915.9 921.0 922.1 922.5 923.5 921.1 921.6 922.5 924.1 924.7 627.8 658.5 663.4 666.5 675.9 14285.3 14290.2 14420.3 14482.3 14506.9 15214.5 15553.5 15668.5 16145.8 16305.9 12236.8 12878.3 13060.0 13081.3 13089.6 3002.8 3024.9 3033.9 3035.6 3035.9 77214.0 79271.0 79535.0 79693.2 79797.6 11954.8 12117.8 12431.6 12527.1 12552.4 22065.9 22244.0 22456.3 22498.7 22561.1 5905.4 5966.0 6021.9 6052.7 6138.5 2826.6 2884.8 2892.5 2894.1 2895.8 3611.7 3671.2 3688.0 3701.6 3702.1 710.0 730.9 735.8 736.9 738.2 599.1 606.6 608.3 622.9 630.5 10130.9 10263.7 10703.7 10836.7 11010.7 566.1 575.2 577.5 582.8 585.3 4566.2 4636.0 4677.5 4679.8 4731.2 83188.6 85602.0 87397.6 89403.1 91239.0 76958.0 77072.0 77695.6 77784.0 78408.6 66651.0 67716.0 69131.7 71209.8 72032.6 9390.2 9443.7 9476.1 9595.0 9825.3 26821.6 31052.7 31141.4 31160.1 31342.1 51107.7 51528.0 51709.7 51862.5 54509.0 14634.0 14735.0 14794.9 15018.2 15033.8 16845.3 16958.4 17126.3 17136.8 17309.5 14759.1 14924.9 15045.9 15111.1 15476.3 14738.1 15188.5 15190.2 15283.7 15351.8 14095.6 14334.9 14688.9 14836.1 15071.3 9657.7 9762.0 9882.2 9892.4 9907.4 11204.7 11617.8 11897.5 12083.5 12202.1 09:08:12 INFO - PID 29798 | -------- Summary: end -------- 09:08:12 INFO - PID 29798 | 09:08:13 INFO - TEST-INFO | 29798: exit 0 09:08:13 INFO - TEST-OK | dromaeo_css | took 1147528ms 09:08:13 INFO - TEST-START | kraken 09:08:13 INFO - operating with platform_type : linux_ 09:08:13 INFO - Initialising browser for kraken test... 09:08:13 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:52185/getInfo.html -profile /tmp/tmpKikXuO/profile 09:08:13 INFO - TEST-INFO | started process 30223 (/builds/slave/test/build/application/firefox/firefox http://localhost:52185/getInfo.html) 09:08:48 INFO - TEST-INFO | 30223: killed by SIGTERM 09:08:48 INFO - Browser initialized. 09:08:48 INFO - Running cycle 1/1 for kraken test... 09:08:48 INFO - TEST-INFO | started process 30444 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKikXuO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:09:00 INFO - PID 30444 | RSS: Main: 176975872 09:09:00 INFO - PID 30444 | 09:09:03 INFO - PID 30444 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52185/tests/kraken/driver.html?testName=audio-beat-detection) 09:09:04 INFO - PID 30444 | RSS: Main: 182505472 09:09:04 INFO - PID 30444 | 09:09:07 INFO - PID 30444 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52185/tests/kraken/driver.html?testName=audio-dft) 09:09:07 INFO - PID 30444 | RSS: Main: 181825536 09:09:07 INFO - PID 30444 | 09:09:10 INFO - PID 30444 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52185/tests/kraken/driver.html?testName=audio-fft) 09:09:11 INFO - PID 30444 | RSS: Main: 179552256 09:09:11 INFO - PID 30444 | 09:09:13 INFO - PID 30444 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52185/tests/kraken/driver.html?testName=audio-oscillator) 09:09:14 INFO - PID 30444 | RSS: Main: 179879936 09:09:14 INFO - PID 30444 | 09:09:16 INFO - PID 30444 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52185/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:09:16 INFO - PID 30444 | RSS: Main: 179888128 09:09:16 INFO - PID 30444 | 09:09:20 INFO - PID 30444 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52185/tests/kraken/driver.html?testName=imaging-darkroom) 09:09:20 INFO - PID 30444 | RSS: Main: 181039104 09:09:20 INFO - PID 30444 | 09:09:24 INFO - PID 30444 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52185/tests/kraken/driver.html?testName=imaging-desaturate) 09:09:24 INFO - PID 30444 | RSS: Main: 179961856 09:09:24 INFO - PID 30444 | 09:09:27 INFO - PID 30444 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52185/tests/kraken/driver.html?testName=json-parse-financial) 09:09:28 INFO - PID 30444 | RSS: Main: 180404224 09:09:28 INFO - PID 30444 | 09:09:29 INFO - PID 30444 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52185/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:09:30 INFO - PID 30444 | RSS: Main: 180809728 09:09:30 INFO - PID 30444 | 09:09:32 INFO - PID 30444 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52185/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:09:33 INFO - PID 30444 | RSS: Main: 180801536 09:09:33 INFO - PID 30444 | 09:09:35 INFO - PID 30444 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52185/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:09:36 INFO - PID 30444 | RSS: Main: 180105216 09:09:36 INFO - PID 30444 | 09:09:38 INFO - PID 30444 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52185/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:09:39 INFO - PID 30444 | RSS: Main: 180629504 09:09:39 INFO - PID 30444 | 09:09:42 INFO - PID 30444 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52185/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:09:43 INFO - PID 30444 | RSS: Main: 180699136 09:09:43 INFO - PID 30444 | 09:09:45 INFO - PID 30444 | Cycle 1(1): loaded http://localhost:52185/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52185/tests/kraken/driver.html?testName=ai-astar) 09:09:45 INFO - PID 30444 | RSS: Main: 182140928 09:09:45 INFO - PID 30444 | 09:09:45 INFO - PID 30444 | __start_tp_report 09:09:45 INFO - PID 30444 | _x_x_mozilla_page_load 09:09:45 INFO - PID 30444 | _x_x_mozilla_page_load_details 09:09:45 INFO - PID 30444 | |i|pagename|runs| 09:09:45 INFO - PID 30444 | |0;ai-astar;104;115;111;110;111;111;111;113;111;111 09:09:45 INFO - PID 30444 | |1;audio-beat-detection;155;128;127;170;129;124;124;125;147;124 09:09:45 INFO - PID 30444 | |2;audio-dft;165;167;166;165;169;169;173;163;163;165 09:09:45 INFO - PID 30444 | |3;audio-fft;78;83;74;101;75;76;74;75;92;73 09:09:45 INFO - PID 30444 | |4;audio-oscillator;85;84;105;88;83;85;101;84;82;101 09:09:45 INFO - PID 30444 | |5;imaging-gaussian-blur;115;115;114;113;114;114;115;118;113;113 09:09:45 INFO - PID 30444 | |6;imaging-darkroom;151;151;151;154;150;151;151;151;151;150 09:09:45 INFO - PID 30444 | |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;94 09:09:45 INFO - PID 30444 | |8;json-parse-financial;54;57;54;55;55;55;55;59;55;55 09:09:45 INFO - PID 30444 | |9;json-stringify-tinderbox;57;57;57;56;56;56;56;56;57;56 09:09:45 INFO - PID 30444 | |10;stanford-crypto-aes;87;87;86;88;87;88;88;89;121;88 09:09:45 INFO - PID 30444 | |11;stanford-crypto-ccm;142;133;138;137;135;134;140;136;135;134 09:09:45 INFO - PID 30444 | |12;stanford-crypto-pbkdf2;204;205;192;199;204;201;202;199;198;185 09:09:45 INFO - PID 30444 | |13;stanford-crypto-sha256-iterative;75;73;75;73;72;78;71;77;74;74 09:09:45 INFO - PID 30444 | __end_tp_report 09:09:45 INFO - PID 30444 | __start_cc_report 09:09:45 INFO - PID 30444 | _x_x_mozilla_cycle_collect,909 09:09:45 INFO - PID 30444 | __end_cc_report 09:09:45 INFO - PID 30444 | __startTimestamp1495642185367__endTimestamp 09:09:45 INFO - PID 30444 | 09:09:45 INFO - PID 30444 | ------- Summary: start ------- 09:09:45 INFO - PID 30444 | Number of tests: 14 09:09:45 INFO - PID 30444 | 09:09:45 INFO - PID 30444 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:2.78 (2.5%) stddev-sans-first:1.51 09:09:45 INFO - PID 30444 | Values: 104.0 115.0 111.0 110.0 111.0 111.0 111.0 113.0 111.0 111.0 09:09:45 INFO - PID 30444 | 09:09:45 INFO - PID 30444 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:128.50 stddev:16.26 (12.7%) stddev-sans-first:15.61 09:09:45 INFO - PID 30444 | Values: 155.0 128.0 127.0 170.0 129.0 124.0 124.0 125.0 147.0 124.0 09:09:45 INFO - PID 30444 | 09:09:45 INFO - PID 30444 | [#2] audio-dft Cycles:10 Average:166.50 Median:166.50 stddev:3.10 (1.9%) stddev-sans-first:3.24 09:09:45 INFO - PID 30444 | Values: 165.0 167.0 166.0 165.0 169.0 169.0 173.0 163.0 163.0 165.0 09:09:45 INFO - PID 30444 | 09:09:45 INFO - PID 30444 | [#3] audio-fft Cycles:10 Average:80.10 Median:75.50 stddev:9.34 (12.4%) stddev-sans-first:9.87 09:09:45 INFO - PID 30444 | Values: 78.0 83.0 74.0 101.0 75.0 76.0 74.0 75.0 92.0 73.0 09:09:45 INFO - PID 30444 | 09:09:45 INFO - PID 30444 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:84.00 stddev:8.85 (10.5%) stddev-sans-first:9.22 09:09:45 INFO - PID 30444 | Values: 85.0 84.0 105.0 88.0 83.0 85.0 101.0 84.0 82.0 101.0 09:09:45 INFO - PID 30444 | 09:09:45 INFO - PID 30444 | [#5] imaging-gaussian-blur Cycles:10 Average:114.40 Median:114.50 stddev:1.51 (1.3%) stddev-sans-first:1.58 09:09:45 INFO - PID 30444 | Values: 115.0 115.0 114.0 113.0 114.0 114.0 115.0 118.0 113.0 113.0 09:09:45 INFO - PID 30444 | 09:09:45 INFO - PID 30444 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 09:09:45 INFO - PID 30444 | Values: 151.0 151.0 151.0 154.0 150.0 151.0 151.0 151.0 151.0 150.0 09:09:45 INFO - PID 30444 | 09:09:45 INFO - PID 30444 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 09:09:45 INFO - PID 30444 | Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 09:09:45 INFO - PID 30444 | 09:09:45 INFO - PID 30444 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.00 stddev:1.51 (2.7%) stddev-sans-first:1.51 09:09:45 INFO - PID 30444 | Values: 54.0 57.0 54.0 55.0 55.0 55.0 55.0 59.0 55.0 55.0 09:09:45 INFO - PID 30444 | 09:09:45 INFO - PID 30444 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:56.50 stddev:0.52 (0.9%) stddev-sans-first:0.50 09:09:45 INFO - PID 30444 | Values: 57.0 57.0 57.0 56.0 56.0 56.0 56.0 56.0 57.0 56.0 09:09:45 INFO - PID 30444 | 09:09:45 INFO - PID 30444 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:88.00 stddev:10.61 (12.1%) stddev-sans-first:11.16 09:09:45 INFO - PID 30444 | Values: 87.0 87.0 86.0 88.0 87.0 88.0 88.0 89.0 121.0 88.0 09:09:45 INFO - PID 30444 | 09:09:45 INFO - PID 30444 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:136.50 stddev:2.88 (2.1%) stddev-sans-first:2.22 09:09:45 INFO - PID 30444 | Values: 142.0 133.0 138.0 137.0 135.0 134.0 140.0 136.0 135.0 134.0 09:09:45 INFO - PID 30444 | 09:09:45 INFO - PID 30444 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.90 Median:201.50 stddev:6.19 (3.1%) stddev-sans-first:6.28 09:09:45 INFO - PID 30444 | Values: 204.0 205.0 192.0 199.0 204.0 201.0 202.0 199.0 198.0 185.0 09:09:45 INFO - PID 30444 | 09:09:45 INFO - PID 30444 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.20 Median:74.50 stddev:2.15 (2.9%) stddev-sans-first:2.26 09:09:45 INFO - PID 30444 | Values: 75.0 73.0 75.0 73.0 72.0 78.0 71.0 77.0 74.0 74.0 09:09:45 INFO - PID 30444 | -------- Summary: end -------- 09:09:45 INFO - PID 30444 | 09:09:46 INFO - TEST-INFO | 30444: exit 0 09:09:46 INFO - TEST-OK | kraken | took 92924ms 09:09:46 INFO - SUITE-END | took 1240s 09:09:46 INFO - Completed test suite (00:20:40) 09:09:46 INFO - javascript benchmark 09:09:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6828.19079202109, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2750.669919609647, 2757.993332433662, 2795.9860200698995, 2811.4939310924024, 2820.097568777991, 5216.400113986892, 5313.442088580697, 5333.626646134772, 5341.172118321666, 5371.731413429327, 5275.709835959021, 5288.0, 5323.707196104213, 5384.1923711443305, 5401.27082843816, 4526.345156666389, 4694.366260554824, 4711.222648263032, 4769.260764581495, 4784.5693887550115, 4802.03959208158, 4805.831795887145, 4808.975955120202, 4844.491328410519, 4853.150698627744, 4668.019715859639, 4680.438347398334, 4708.223143181371, 4729.125111854283, 4736.123817093814, 4767.237242041257, 4770.0698363819065, 4770.928436073462, 4784.42586889572, 4814.422269327703, 4685.812567497296, 4715.292706094079, 4737.715737055788, 4742.644301677354, 4759.452662943771, 5232.816851410221, 5282.867928301823, 5302.575793936476, 5315.468453154692, 5346.331708536433, 5716.942830571724, 5736.340320863071, 5817.447342502455, 5832.475077243069, 5834.0373838317055, 5784.07454807233, 5784.537237021028, 5786.855328616818, 5789.45000224978, 5834.445727655866, 5350.464953504618, 5364.409914909357, 5365.678059316453, 5367.409584945653, 5368.785248590091, 5846.853828654318, 5923.111533269957, 5925.081612350006, 5932.872754176693, 5991.670458124758, 5616.887662246732, 5659.575531835047, 5664.291963504562, 5665.2635157430095, 5702.173184888168, 5592.189132575835, 5680.630759000652, 5718.857028574235, 5737.282839645044, 5745.482906538348, 5572.777088916398, 5611.410801865745, 5664.235328230719, 5766.221560089334, 5788.855278617984, 5699.059655156852, 5772.62477938941, 5781.739821708034, 5781.768729250867, 5795.0, 4741.502142275081, 4746.715197088117, 4748.572628463455, 4754.7147171169845, 4776.832810851603, 4001.6198461146146, 4085.22380747657, 4085.346344584852, 4086.693497987663, 4094.754314741125, 4811.831585894547, 4839.2983017462275, 4899.363082799285, 4913.1893237616105, 4922.138625740481, 5786.189933409326, 5801.216835727208, 5806.4193580641595, 5807.651540907559, 5813.82558523245, 4771.451283102488, 4786.736729479912, 4797.56821886032, 4852.0295940811275, 4854.344663470457, 4978.726170060609, 4980.327655766498, 5036.874078148002, 5090.4655011223285, 5094.643374963717, 5438.510534051954, 5439.265699130567, 5441.102218133963, 5446.591505637172, 5454.590905682169, 5721.399253078367, 5772.076467765138, 5805.506531944663, 5829.38791426911, 5831.0, 5374.247605335335, 5417.674939503642, 5443.755031023693, 5443.945560544344, 5447.918281225706, 5732.05421105513, 5741.770329186953, 5749.8275051748515, 5752.223449834386, 5759.078547432391, 5715.714214289185, 5841.4450627190345, 5843.0, 5844.3571207168025, 5862.267216597926, 5591.832245032656, 5596.384397716167, 5682.602217844711, 5684.033714268501, 5687.857803554944, 5606.775728970795, 5609.1305847593685, 5610.438956104357, 5615.971920140537, 5645.209670646031, 5517.724113794214, 5531.529819965348, 5549.805756798654, 5554.805581804618, 5557.44425557441, 5580.330360356783, 5616.634918730269, 5659.0, 5666.914996275142, 5673.120666296731, 5495.862603434946, 5501.367342755474, 5515.145152501369, 5515.4760297771645, 5515.862103447446], "value": 5216.352862922976, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.8180000499862, 711.6726305899286, 733.1349008170358, 1048.617254702034, 1071.0467683761449, 29653.110406687807, 33362.66637333629, 33540.49689254657, 33544.66455335449, 33603.66396336036, 35847.82076089616, 36062.81968590154, 36274.63725362746, 36274.8186259069, 36368.09079773007, 6436.163298771153, 6902.413294869942, 6998.405135563483, 7000.719971201146, 7012.26371231021, 6610.537262391635, 6641.236257830339, 6700.932990670104, 6702.966485167567, 6720.59676419414, 6658.733650653992, 6740.797776066725, 6755.864882702367, 6762.425193858528, 6764.7970560883, 6688.93311066888, 6715.093462382565, 6717.6977036033495, 6736.966315168393, 6737.056812046293, 6725.361090696376, 6758.729650813962, 6765.154355705537, 6770.356816102511, 6785.864282714368, 32172.517412238834, 32315.353692926245, 32329.353412931843, 32374.6762532374, 32452.0, 3002.519596864513, 3036.7266945974748, 3044.436779195834, 3056.66376698563, 3056.770742194322, 24860.50278994428, 24869.875650621812, 24918.37704057395, 24935.625965610532, 24945.750542494523, 2915.052607902419, 2926.692697266799, 2931.4723349797027, 2940.794144409892, 2956.068838315945, 142975.0, 144151.0, 144309.2784536081, 145437.0, 146347.0, 38438.807805960794, 38597.80701096533, 38669.22661546753, 38678.22643547113, 38783.806080969414, 39841.800790996436, 39916.806655467495, 39946.0, 39993.400098998536, 40027.79986100051, 11076.11391088711, 11076.169287303484, 11143.554257829757, 11206.607768728056, 11220.831687524693, 8765.780855478664, 8848.336374771918, 8858.202761751345, 8858.424202426822, 8860.424072435271, 12606.306653134166, 12642.873571264354, 12707.174033687781, 12746.171498852545, 12898.161619494704, 5111.904119311064, 5117.565006974449, 5174.767135478913, 5332.226827110125, 5339.652922560022, 863.6329559937002, 879.208712159062, 893.2228960804142, 894.3158483759929, 932.421898422982, 20186.89545876839, 21077.0, 21123.838188899757, 21216.469588260417, 21375.893120534296, 957.2055194188806, 962.7833737409027, 963.8987906269881, 970.3013830042358, 988.5008070924138, 10438.582456701646, 11412.087033037336, 11500.137489688139, 14343.354549045318, 14872.851271487363, 172333.0, 173224.0, 173408.13295933438, 174142.0, 175735.0, 43829.0, 44219.33670994938, 44369.778151109036, 44471.33293000607, 44697.55302446999, 1160.651804458676, 1208.2025862930423, 1209.2683926224684, 1212.3332167308122, 1214.180428210954, 23236.651450228597, 23660.52678946377, 25135.74864251407, 25166.24501264965, 25189.49621007533, 29956.0, 29981.100566983027, 30195.396092078474, 30212.395752085275, 30227.395452091274, 152434.23782881457, 152543.0, 153532.23233883758, 153666.0, 154419.0, 28111.297217569725, 28380.57429138606, 28494.0, 28581.42837143287, 28653.14040578786, 35002.12494687551, 35332.11669708175, 35509.82245088758, 35635.46546801748, 35675.82162089277, 26086.60870086988, 26602.866985664947, 26643.200703978913, 26919.192424227305, 27354.5896811544, 26323.46232421613, 26555.0, 27476.862615686794, 27504.862475687492, 28049.579256310764, 30164.681884992195, 30249.697503024687, 30281.24296892595, 30306.696933030387, 30376.696233037386, 25823.741762582886, 25835.354116147246, 26354.0, 26413.60379594269, 27458.313542160806, 20546.507093793793, 21301.46746331354, 21308.590625499844, 21546.569068618854, 21569.0], "value": 14343.17298633805, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.30791099709484, 422.39386480400606, 430.38240125420015, 439.4024127187025, 441.64006334837103, 14121.717565648682, 14844.257787110655, 17341.21964511597, 17952.82047179528, 18023.549411264725, 16363.181840907937, 16438.0, 16655.66688666226, 16667.91666041671, 16791.748123778154, 5470.097433923398, 5616.185653080301, 5666.688332141731, 5669.9433005670035, 5674.744636491368, 5363.088274993261, 5521.834344969658, 5542.7782888684405, 5552.278203833496, 5552.611317207797, 5190.2474141249495, 5427.375851777037, 5452.945470545284, 5512.862178445531, 5526.143447765583, 5263.868403289929, 5277.050130976423, 5294.126469132589, 5296.073187192226, 5311.282976798121, 4804.111239420718, 4807.134715751164, 4834.274858771178, 4948.87627809304, 4983.227599722049, 21921.671174932388, 22265.77734222653, 22329.553408931894, 22389.44026399337, 22581.435464113365, 1535.9232038398036, 1537.4311504743316, 1542.3290868472138, 1561.0, 1623.3506597361031, 14144.0, 14220.360083796253, 14568.0, 14624.195669238188, 14626.195559244237, 2038.2458490358515, 2050.4156315450027, 2096.5911647228795, 2107.4942013916702, 2116.968245476319, 90247.0, 92756.0, 93215.0, 97416.51291743567, 98202.01797982, 10982.286151400134, 11298.943505282421, 11342.943285283522, 11386.658400248005, 11458.140639452075, 15864.73082153448, 15917.840821591635, 15926.681466370608, 15940.681186376207, 16032.75950860738, 6670.166229221348, 6782.406134558375, 7028.753993610199, 7077.115360579927, 7251.7099316027825, 5974.85062873423, 6057.545684073712, 6118.908216376758, 6126.142340072393, 6203.96898015507, 6943.79168624942, 6976.476764242702, 7031.367176954099, 7038.507304488637, 7110.466714996396, 2001.319551352547, 2001.7197592337084, 2052.835773138145, 2060.7424071991, 2211.3918672364907, 829.9377546684022, 862.1034124510564, 879.0857508191409, 887.7691800131882, 894.9507777072323, 16933.32266709318, 16977.575560611083, 16991.150442478072, 17272.65454690899, 17591.73612395815, 866.8916385451819, 871.1201686296886, 875.1161327059589, 875.3216257400566, 893.2273583350355, 9168.220701240469, 9210.861837072316, 9470.763230919281, 9478.857817132748, 9487.47818869955, 341698.0, 347868.0, 348661.0, 348685.0, 348711.0, 74057.6297118511, 75361.0, 76313.23686763173, 76567.61716191383, 78373.0, 1057.3867157048894, 1067.0769784136821, 1099.6700989703056, 1103.475848971732, 1107.684309971654, 17472.91263543674, 17622.559436014202, 18103.275868965622, 18328.725069123706, 18836.623267534298, 39516.0, 39676.404853927794, 40176.19207135744, 40550.39174412445, 40880.79559602183, 48338.75830620824, 48377.516224838706, 49129.50870491249, 49957.0, 50527.49472505228, 8093.838123237385, 8347.12355202695, 8576.485410875368, 8678.613097196898, 8755.693550725695, 12473.563425280072, 12496.562620308245, 12712.555060572835, 12721.045921555735, 12894.355282235663, 10446.895531044593, 10686.89313106859, 10913.618023369145, 11182.832257515982, 11811.350375729073, 10508.42203678805, 10847.349159050167, 10896.346219226873, 11028.613998510014, 11305.547778088785, 10745.462726863469, 11336.603218887629, 11513.194076414906, 11542.19204655666, 12169.878301216875, 8199.877001845096, 8315.708950186714, 8368.958155209428, 8377.413581049268, 8406.537640429835, 10801.67594972152, 10823.80938096793, 10908.781824363627, 11043.226974111734, 11090.611828585961], "value": 8786.360859893903, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1272.4782839035995, 1307.3267267357307, 1325.933703314834, 1328.3690247132613, 1346.0779366134195, 9950.303478756481, 10094.848577271347, 10408.167346612272, 10425.53085111169, 10636.361818290909, 10252.53863576139, 10459.895401046006, 10469.214808889326, 10478.10936070433, 10515.894841051588, 2196.374033400485, 2225.18780645065, 2226.265332440291, 2229.698990636268, 2250.088714070804, 2107.620628286908, 2117.375374264588, 2122.129926730041, 2132.8720276783365, 2148.7636360000465, 2038.704387863759, 2052.5586998795256, 2059.640637179462, 2059.691046343053, 2064.0505367530877, 2061.762897266811, 2067.824234940032, 2082.552251265985, 2083.14591017682, 2084.8749075055543, 1920.0783623860486, 2002.3892712722613, 2028.8782673039666, 2059.4542446251753, 2063.0716177719937, 10257.487125643687, 10289.742756431075, 10330.0, 10330.89669103307, 10349.637762678345, 5164.870878228036, 5350.49170328822, 5403.51368376844, 5403.78384864605, 5403.8108666196495, 3170.6036745406823, 3285.063756829316, 3338.132085657722, 3355.3624811285777, 3356.7650264481495, 1108.4457771114444, 1122.2480937771713, 1145.8682251541013, 1166.0729719872722, 1184.0231808757724, 14811.925940370336, 14995.850041499554, 15006.924965375103, 15017.474388396464, 15050.32273547682, 4661.766911654404, 4731.834385796549, 4869.0, 4927.127691477287, 4936.0, 10230.437325947145, 10265.846012309821, 10302.587896484056, 10309.84535231972, 10343.63797267092, 4992.0, 5129.769160387791, 5132.409772876167, 5140.203268493389, 5155.61332900034, 4709.340692303081, 4802.255650374198, 4809.470958194595, 4811.422629284439, 4813.205821039559, 3734.79458629778, 3833.9808300958316, 3842.538895332578, 3860.864869729546, 3892.2215556888737, 1097.7145942054963, 1101.5869049106584, 1104.7072525780675, 1105.5854054729477, 1121.1759356872692, 724.8658998085372, 750.0923882102717, 751.9849603008018, 758.8785794273, 765.6860687118254, 5739.16782066598, 5746.827595172152, 5819.709014549256, 5889.469947704727, 5950.256217972754, 821.1542111625035, 830.1449507007671, 835.2983493865182, 843.8987321521457, 849.3332733803934, 3675.650813172744, 3997.200559888034, 4004.619561141687, 4101.200265948171, 4265.274903266452, 13354.93322533381, 13474.0, 13606.455741770218, 13618.863811361958, 13672.794908076386, 13083.280419576824, 13100.886424653821, 13378.13042152257, 13495.59513214605, 13496.39266233022, 7537.2085930976455, 7562.621868906643, 7679.232076792276, 7733.110692270348, 7747.418943579254, 6414.326495717883, 6536.542442029012, 6562.901556476561, 6706.93293067063, 6762.763303284361, 11813.350265735124, 12185.268883866996, 12201.51193952232, 12219.45012474423, 12281.69295767613, 12242.510299587917, 12277.815832762695, 12300.07749418815, 12475.812862806884, 12494.937525312314, 8983.146601072887, 9355.0, 9510.476923768982, 9529.094736000068, 9535.952320238355, 9511.429314241168, 9702.078302561245, 9703.07820757027, 9719.0, 9725.6596019139, 7851.882221766564, 7966.123726389977, 8171.713990010321, 8285.917140828757, 8397.328213742763, 7622.0, 7922.683092676229, 8015.198480151938, 8024.719134830253, 8175.7138500152205, 7419.29516695913, 7537.472376933562, 7551.433642476726, 7552.509086909334, 7560.054993125859, 5574.108142697149, 5648.4633959773755, 5703.971480142739, 5898.20374249488, 5994.520438365008, 5745.070014292824, 5761.337446193741, 5774.769009239583, 5804.854878628068, 5963.73163207648], "value": 4773.806906977752, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.8032403474229, 388.3185010306911, 388.45616137407626, 392.24688597892043, 395.5984675554311, 5452.536534394581, 5485.835424937259, 5493.368262649797, 5495.258140151083, 5589.916151257735, 5403.459654034595, 5475.780968761244, 5493.313335833011, 5518.709735459779, 5543.113101903697, 4219.430376899126, 4366.083122544277, 4378.759168245745, 4394.780260986954, 4396.054848207635, 4365.148795984785, 4386.6929314947965, 4399.824007039714, 4410.235905637738, 4421.9336709949375, 4332.97833510832, 4368.868933931971, 4384.254676704968, 4407.2948328267485, 4418.911621767563, 4310.676699247553, 4360.803763830635, 4376.124775044972, 4399.164158809832, 4400.44994375703, 3966.484357033596, 3983.342748446503, 3996.220736956295, 4013.4581831452674, 4020.19596080785, 5412.269343638598, 5458.181272809071, 5458.945410545924, 5461.808836690697, 5463.262459567947, 5100.285959965608, 5156.948430515685, 5217.947820521784, 5224.111900976843, 5228.503292187274, 5887.676177810219, 5888.970555147197, 5918.970405147989, 5928.28860536734, 5942.019566771478, 4494.662900282492, 4503.369528266046, 4503.729776213405, 4506.481754598198, 4519.751413672247, 5885.764569417218, 5971.940280597225, 6048.60684055535, 6101.101976561143, 6174.722137503778, 4341.8480353188115, 4352.934705979413, 4384.780760962003, 4390.560943905648, 4399.64802815774, 4445.0, 4446.955530444654, 4449.844255451044, 4450.577195166454, 4469.08383781324, 4961.231009193581, 4999.875003124951, 5021.221710634857, 5035.269885866529, 5189.221616757441, 5877.706114694333, 5906.114082887601, 5918.7928422505, 5920.851978700481, 5943.732532036069, 1622.9350825966828, 1647.604574902015, 1649.736042233237, 1652.8760342974324, 1659.556186118085, 1161.2916121166081, 1178.6640807369859, 1199.1066655341826, 1206.6681662542871, 1209.5524655877382, 5006.899862002812, 5007.6494645375205, 5008.974955125274, 5024.949750502448, 5033.5721463676, 6002.4897883679505, 6006.879862402728, 6029.60807547508, 6040.395960404012, 6049.425304596057, 4852.660313778002, 4992.15133427311, 5011.323471331397, 5019.322391477177, 5026.396832380065, 3183.2678483948357, 3200.871965121369, 3203.6796320367775, 3215.6784321567657, 3228.3059142284524, 5496.80761173357, 5618.0, 5642.520385767256, 5654.042170480598, 5694.9430505695245, 6193.938060619426, 6235.75056997715, 6246.75012999484, 6250.468710159596, 6288.434040936338, 5592.133219351007, 5617.831465056055, 5635.633034125677, 5644.0, 5667.858303542444, 5936.821895343147, 5945.464908158287, 6013.128096425906, 6045.667488288186, 6077.511009802627, 5879.795076846182, 5917.852053698692, 5955.4391611607425, 5964.343922168471, 5966.3735307793795, 5485.546330222414, 5585.3297604287745, 5588.441155884541, 5650.107214083164, 5658.943410565842, 4142.751434913915, 4159.584041595937, 4172.937405938853, 4177.874663760092, 4180.393842892703, 5930.169776231245, 6092.268927728701, 6141.078838174131, 6168.475679567107, 6170.568060235741, 5845.561582881216, 5856.677882716492, 5869.148973398748, 5888.440598143169, 5905.940940590539, 5840.948629246776, 5881.117832325185, 5893.145493903275, 5905.232319798399, 5920.79277225295, 5639.436056394327, 5676.508946997485, 5731.168980497721, 5786.797462088806, 5790.1893734877995, 5890.764369425175, 5902.557308201816, 5912.763489460373, 5924.6149000314845, 5930.406959304035, 5585.273914391103, 5684.886302273849, 5710.0, 5720.599558030898, 5743.712814359349], "value": 4483.834469101925, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.0222076878143, 675.689182975831, 694.2086021934994, 696.7143471176819, 701.7228194863028, 12928.806067908978, 13398.531051413203, 13440.865591344096, 14845.406183752664, 15262.160581168031, 16252.268647910843, 16464.094474803882, 16475.340986360563, 16544.50366489007, 16552.420665276717, 855.7047818502607, 867.9913200868006, 868.4572142410993, 868.956552172392, 870.708312715238, 874.7463235661683, 877.3639111644039, 877.8376000439939, 878.8857448531681, 880.5949263338872, 915.945043297401, 921.0283151275402, 922.1470140120396, 922.5110691333604, 923.501309292981, 921.1019256225161, 921.6313474610176, 922.4649703172144, 924.1405492891608, 924.6671198368582, 627.7991042866284, 658.4633523678187, 663.3863676099637, 666.4601672645173, 675.8918573028341, 14285.285735713172, 14290.214038227894, 14420.278986050656, 14482.348294326675, 14506.92746536271, 15214.543563693107, 15553.533393998197, 15668.451604193799, 16145.757813632805, 16305.91847040769, 12236.81644775329, 12878.29169395683, 13060.0, 13081.280529570964, 13089.607311780663, 3002.8498575071158, 3024.8638811253545, 3033.8634761435787, 3035.6357237131465, 3035.893743718981, 77214.0, 79271.0, 79534.99999999942, 79693.20306796915, 79797.60101199515, 11954.820677689842, 12117.818232726517, 12431.62705118848, 12527.123101382816, 12552.43514041852, 22065.889670551867, 22244.0, 22456.32631021072, 22498.66252006221, 22561.09755609757, 5905.379935106838, 5965.970170149121, 6021.879562408727, 6052.697365131726, 6138.508919286446, 2826.632537770118, 2884.769218462518, 2892.464893994618, 2894.1028281232884, 2895.8407287599384, 3611.656892595199, 3671.2473942841652, 3688.0, 3701.648343407372, 3702.0559757261726, 709.9787006389816, 730.9159446663701, 735.7608777147342, 736.9447291453055, 738.2211766586303, 599.1372423709844, 606.6269244414741, 608.3308360803081, 622.9003359462464, 630.4578062865932, 10130.949345253373, 10263.692089237335, 10703.73240668974, 10836.67489975302, 11010.724731881606, 566.0631654611624, 575.2464271803867, 577.4946921443736, 582.7931084464954, 585.2917969257246, 4566.178087944136, 4636.0, 4677.462091859412, 4679.789409476582, 4731.243001119804, 83188.58405708054, 85602.0, 87397.56301218453, 89403.10596894078, 91239.0, 76958.0, 77072.0, 77695.61152194203, 77784.0, 78408.60795695985, 66651.0, 67716.0, 69131.65434172898, 71209.795559201, 72032.63983680047, 9390.154886060287, 9443.716688499357, 9476.147146756824, 9594.952025239829, 9825.312228144247, 26821.597676035264, 31052.68947310498, 31141.377172456876, 31160.065198044096, 31342.05973820789, 51107.74446127894, 51528.0, 51709.7414512925, 51862.481375185766, 54509.0, 14634.0, 14735.0, 14794.926025369805, 15018.249087545797, 15033.774493382827, 16845.326186952385, 16958.406455773988, 17126.314947401963, 17136.828631713524, 17309.480715578553, 14759.114453132846, 14924.925375373054, 15045.924770376078, 15111.093334399971, 15476.303566339317, 14738.11571305725, 15188.544343669708, 15190.240487975778, 15283.694326113193, 15351.84648153549, 14095.647608809451, 14334.928325358307, 14688.926555367154, 14836.10983341003, 15071.321790519673, 9657.661981830603, 9762.0, 9882.209423246266, 9892.406455612687, 9907.356021858555, 11204.66386008421, 11617.825732613848, 11897.46461409256, 12083.456244469196, 12202.14584979043], "value": 7202.259475338628, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1555.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 111.0, 110.0, 111.0, 111.0, 111.0, 113.0, 111.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 128.0, 127.0, 170.0, 129.0, 124.0, 124.0, 125.0, 147.0, 124.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 167.0, 166.0, 165.0, 169.0, 169.0, 173.0, 163.0, 163.0, 165.0], "value": 166.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 83.0, 74.0, 101.0, 75.0, 76.0, 74.0, 75.0, 92.0, 73.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 105.0, 88.0, 83.0, 85.0, 101.0, 84.0, 82.0, 101.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 115.0, 114.0, 113.0, 114.0, 114.0, 115.0, 118.0, 113.0, 113.0], "value": 114.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 154.0, 150.0, 151.0, 151.0, 151.0, 151.0, 150.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 54.0, 55.0, 55.0, 55.0, 55.0, 59.0, 55.0, 55.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 57.0, 56.0, 56.0, 56.0, 56.0, 56.0, 57.0, 56.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 88.0, 87.0, 88.0, 88.0, 89.0, 121.0, 88.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 133.0, 138.0, 137.0, 135.0, 134.0, 140.0, 136.0, 135.0, 134.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 205.0, 192.0, 199.0, 204.0, 201.0, 202.0, 199.0, 198.0, 185.0], "value": 198.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 75.0, 73.0, 72.0, 78.0, 71.0, 77.0, 74.0, 74.0], "value": 74.2, "unit": "score"}]}]} 09:09:46 INFO - Return code: 0 09:09:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:09:46 INFO - # TBPL SUCCESS # 09:09:46 INFO - Running post-action listener: _resource_record_post_action 09:09:46 INFO - [mozharness: 2017-05-24 16:09:46.655962Z] Finished run-tests step (success) 09:09:46 INFO - Running post-run listener: _resource_record_post_run 09:09:46 INFO - Total resource usage - Wall time: 1257s; CPU: 13.0%; Read bytes: 4096; Write bytes: 421163008; Read time: 12; Write time: 502284 09:09:46 INFO - TinderboxPrint: CPU usage
12.9% 09:09:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:09:46 INFO - TinderboxPrint: I/O write bytes / time
421,163,008 / 502,284 09:09:46 INFO - TinderboxPrint: CPU idle
8,744.1 (87.1%) 09:09:46 INFO - TinderboxPrint: CPU user
1,231.5 (12.3%) 09:09:46 INFO - TinderboxPrint: Swap in / out
0 / 0 09:09:46 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 113876992; Read time: 0; Write time: 165396 09:09:46 INFO - run-tests - Wall time: 1241s; CPU: 13.0%; Read bytes: 0; Write bytes: 307286016; Read time: 0; Write time: 336888 09:09:47 INFO - Running post-run listener: _upload_blobber_files 09:09:47 INFO - Blob upload gear active. 09:09:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:09:47 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:09:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:09:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:09:47 INFO - (blobuploader) - INFO - Open directory for files ... 09:09:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:09:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:09:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:48 INFO - (blobuploader) - INFO - Done attempting. 09:09:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:09:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:09:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:49 INFO - (blobuploader) - INFO - Done attempting. 09:09:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:09:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:09:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:55 INFO - (blobuploader) - INFO - Done attempting. 09:09:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:09:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:09:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:09:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:09:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:09:56 INFO - (blobuploader) - INFO - Done attempting. 09:09:56 INFO - (blobuploader) - INFO - Iteration through files over. 09:09:56 INFO - Return code: 0 09:09:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:09:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:09:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82554fa1196b572ab75e856ad482c3f6f12f63b26d9a5e0dcc57959390ae1b8e97dcf452c1598a7b66d92191e755f1d706156cadae1d59fc140646db7ad664b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/468442c23f00c7e27a11ea49d05498b5ce462d526d90b6a781d7e98eb568a1ca95f3e17114bbc6b105170b14800f81511c7f9a29a0afa6aff2a523340824c80d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68602b7060c253d9633eb482aaaf9266729862c75e804aed61076f213c447e637835b203a81e94fa0817ccbc04cbc7dbf9284f6cf2c25575ad1043ed2420366a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23513d2bda4b269f2b3d17b043c10f1a56bb693dfb061229672276358540081186829b5b2705a27a09b84d2cd4ece5e37718c77393f7bcb14d7a12b13142745b"} 09:09:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:09:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:09:56 INFO - Contents: 09:09:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82554fa1196b572ab75e856ad482c3f6f12f63b26d9a5e0dcc57959390ae1b8e97dcf452c1598a7b66d92191e755f1d706156cadae1d59fc140646db7ad664b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/468442c23f00c7e27a11ea49d05498b5ce462d526d90b6a781d7e98eb568a1ca95f3e17114bbc6b105170b14800f81511c7f9a29a0afa6aff2a523340824c80d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68602b7060c253d9633eb482aaaf9266729862c75e804aed61076f213c447e637835b203a81e94fa0817ccbc04cbc7dbf9284f6cf2c25575ad1043ed2420366a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23513d2bda4b269f2b3d17b043c10f1a56bb693dfb061229672276358540081186829b5b2705a27a09b84d2cd4ece5e37718c77393f7bcb14d7a12b13142745b"} 09:09:56 INFO - Running post-run listener: copy_logs_to_upload_dir 09:09:56 INFO - Copying logs to upload dir... 09:09:56 INFO - mkdir: /builds/slave/test/build/upload/logs 09:09:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1317.199107 ========= master_lag: 0.14 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 57 secs) (at 2017-05-24 09:09:56.338817) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-24 09:09:56.343177) ========= 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=5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999 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/82554fa1196b572ab75e856ad482c3f6f12f63b26d9a5e0dcc57959390ae1b8e97dcf452c1598a7b66d92191e755f1d706156cadae1d59fc140646db7ad664b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/468442c23f00c7e27a11ea49d05498b5ce462d526d90b6a781d7e98eb568a1ca95f3e17114bbc6b105170b14800f81511c7f9a29a0afa6aff2a523340824c80d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68602b7060c253d9633eb482aaaf9266729862c75e804aed61076f213c447e637835b203a81e94fa0817ccbc04cbc7dbf9284f6cf2c25575ad1043ed2420366a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23513d2bda4b269f2b3d17b043c10f1a56bb693dfb061229672276358540081186829b5b2705a27a09b84d2cd4ece5e37718c77393f7bcb14d7a12b13142745b"} build_url:https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011318 build_url: 'https://queue.taskcluster.net/v1/task/Aa3_LsyEQ76S4Lrw46uboA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/82554fa1196b572ab75e856ad482c3f6f12f63b26d9a5e0dcc57959390ae1b8e97dcf452c1598a7b66d92191e755f1d706156cadae1d59fc140646db7ad664b0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/468442c23f00c7e27a11ea49d05498b5ce462d526d90b6a781d7e98eb568a1ca95f3e17114bbc6b105170b14800f81511c7f9a29a0afa6aff2a523340824c80d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/68602b7060c253d9633eb482aaaf9266729862c75e804aed61076f213c447e637835b203a81e94fa0817ccbc04cbc7dbf9284f6cf2c25575ad1043ed2420366a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23513d2bda4b269f2b3d17b043c10f1a56bb693dfb061229672276358540081186829b5b2705a27a09b84d2cd4ece5e37718c77393f7bcb14d7a12b13142745b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-24 09:09:56.370185) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 09:09:56.370503) ========= 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=5cf47e208febbcd81da23b2e0000026f-1495640877.468369-916122999 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-24 09:09:56.451789) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-24 09:09:56.452116) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-24 09:09:56.452423) ========= ========= Total master_lag: 0.30 =========