builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-044 starttime: 1495717767.2 results: success (0) revision: e8da7192201e5786614ec49d557e64dffd114ff2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 06:09:27.205374) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-25 06:09:27.205745) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 06:09:27.206010) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-25 06:09:27.237923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:09:27.238376) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-25 06:09:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 109M=0s 2017-05-25 06:09:27 (109 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076434 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:09:27.328766) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:09:27.329060) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015038 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:09:27.378342) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:09:27.378656) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e8da7192201e5786614ec49d557e64dffd114ff2 --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 e8da7192201e5786614ec49d557e64dffd114ff2 --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=88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-25 06:09:27,943 truncating revision to first 12 chars 2017-05-25 06:09:27,943 Setting DEBUG logging. 2017-05-25 06:09:27,944 attempt 1/10 2017-05-25 06:09:27,944 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e8da7192201e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-25 06:09:28,376 unpacking tar archive at: mozilla-central-e8da7192201e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.837683 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:09:28.229208) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 06:09:28.229499) ========= script_repo_revision: e8da7192201e5786614ec49d557e64dffd114ff2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-25 06:09:28.229883) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 06:09:28.230150) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-25 06:09:28.238093) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-05-25 06:09:28.238381) ========= /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=88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:09:28 INFO - MultiFileLogger online at 20170525 06:09:28 in /builds/slave/test 06:09:28 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 06:09:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:09:28 INFO - {'append_to_log': False, 06:09:28 INFO - 'base_work_dir': '/builds/slave/test', 06:09:28 INFO - 'blob_upload_branch': 'Firefox', 06:09:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:09:28 INFO - 'branch': 'Firefox', 06:09:28 INFO - 'buildbot_json_path': 'buildprops.json', 06:09:28 INFO - 'config_files': ('talos/linux_config.py',), 06:09:28 INFO - 'default_actions': ('clobber', 06:09:28 INFO - 'read-buildbot-config', 06:09:28 INFO - 'download-and-extract', 06:09:28 INFO - 'populate-webroot', 06:09:28 INFO - 'create-virtualenv', 06:09:28 INFO - 'install', 06:09:28 INFO - 'run-tests'), 06:09:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:09:28 INFO - 'download_minidump_stackwalk': True, 06:09:28 INFO - 'download_symbols': 'ondemand', 06:09:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:09:28 INFO - 'tooltool.py': '/tools/tooltool.py', 06:09:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:09:28 INFO - '/tools/misc-python/virtualenv.py')}, 06:09:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:09:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:09:28 INFO - 'gecko_profile': False, 06:09:28 INFO - 'gecko_profile_interval': 0, 06:09:28 INFO - 'installer_path': 'installer.exe', 06:09:28 INFO - 'log_level': 'info', 06:09:28 INFO - 'log_name': 'talos', 06:09:28 INFO - 'log_to_console': True, 06:09:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:09:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:09:28 INFO - 'opt_config_files': (), 06:09:28 INFO - 'pip_index': False, 06:09:28 INFO - 'suite': 'dromaeojs-e10s', 06:09:28 INFO - 'system_bits': '32', 06:09:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:09:28 INFO - 'title': 'talos-linux64-ix-044', 06:09:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:09:28 INFO - 'use_talos_json': True, 06:09:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:09:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:09:28 INFO - 'work_dir': 'build'} 06:09:28 INFO - [mozharness: 2017-05-25 13:09:28.906061Z] Running clobber step. 06:09:28 INFO - Running pre-action listener: _resource_record_pre_action 06:09:28 INFO - Running main action method: clobber 06:09:28 INFO - rmtree: /builds/slave/test/build 06:09:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:09:29 INFO - Running post-action listener: _resource_record_post_action 06:09:29 INFO - [mozharness: 2017-05-25 13:09:29.930441Z] Finished clobber step (success) 06:09:29 INFO - [mozharness: 2017-05-25 13:09:29.930542Z] Running read-buildbot-config step. 06:09:29 INFO - Running pre-action listener: _resource_record_pre_action 06:09:29 INFO - Running main action method: read_buildbot_config 06:09:29 INFO - Using buildbot properties: 06:09:29 INFO - { 06:09:29 INFO - "project": "", 06:09:29 INFO - "product": "firefox", 06:09:29 INFO - "who": "bhearsum@mozilla.com", 06:09:29 INFO - "installer_path": "public/build/target.tar.bz2", 06:09:29 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 06:09:29 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 06:09:29 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 06:09:29 INFO - "stage_platform": "linux64-stylosequential", 06:09:29 INFO - "basedir": "/builds/slave/test", 06:09:29 INFO - "buildnumber": 17, 06:09:29 INFO - "platform": "ubuntu64_hw_styloseq", 06:09:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:09:29 INFO - "slavebuilddir": "test", 06:09:29 INFO - "taskId": "ayPtg6JpSFaqaXTUWiSP9g", 06:09:29 INFO - "branch": "mozilla-central", 06:09:29 INFO - "script_repo_revision": "production", 06:09:29 INFO - "revision": "e8da7192201e5786614ec49d557e64dffd114ff2", 06:09:29 INFO - "slavename": "talos-linux64-ix-044", 06:09:29 INFO - "repo_path": "mozilla-central" 06:09:29 INFO - } 06:09:29 INFO - Finding installer, test and symbols from parent task. 06:09:29 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ayPtg6JpSFaqaXTUWiSP9g'}, attempt #1 06:09:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ayPtg6JpSFaqaXTUWiSP9g'}, attempt #1 06:09:30 INFO - Task dependencies: awcs871OSjuZ3n2G3PaW4A 06:09:30 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/awcs871OSjuZ3n2G3PaW4A'}, attempt #1 06:09:31 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/target.tar.bz2 06:09:31 INFO - Set test_url: https://queue.taskcluster.net/v1/task/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/test_packages.json 06:09:31 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/target.crashreporter-symbols.zip 06:09:31 INFO - Running post-action listener: _resource_record_post_action 06:09:31 INFO - [mozharness: 2017-05-25 13:09:31.289971Z] Finished read-buildbot-config step (success) 06:09:31 INFO - [mozharness: 2017-05-25 13:09:31.290192Z] Running download-and-extract step. 06:09:31 INFO - Running pre-action listener: _resource_record_pre_action 06:09:31 INFO - Running main action method: download_and_extract 06:09:31 INFO - mkdir: /builds/slave/test/build/tests 06:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:09:31 INFO - trying https://queue.taskcluster.net/v1/task/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/target.test_packages.json 06:09:31 INFO - Downloading https://queue.taskcluster.net/v1/task/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:09:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:09:31 INFO - Downloaded 989 bytes. 06:09:31 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:09:31 INFO - Using the following test package requirements: 06:09:31 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:09:31 INFO - u'common': [u'target.common.tests.zip'], 06:09:31 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:09:31 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:09:31 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:09:31 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:09:31 INFO - u'mozbase': [u'target.common.tests.zip'], 06:09:31 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:09:31 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:09:31 INFO - u'web-platform': [u'target.common.tests.zip', 06:09:31 INFO - u'target.web-platform.tests.tar.gz'], 06:09:31 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:09:31 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:09:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/target.common.tests.zip 06:09:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:09:31 INFO - Fetch https://queue.taskcluster.net/v1/task/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/target.common.tests.zip into memory 06:09:33 INFO - Content-Length response header: 63524936 06:09:33 INFO - Bytes received: 63524936 06:09:44 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:09:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/target.common.tests.zip 06:09:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:09:44 INFO - Fetch https://queue.taskcluster.net/v1/task/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/target.common.tests.zip into memory 06:09:46 INFO - Content-Length response header: 63524936 06:09:46 INFO - Bytes received: 63524936 06:09:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/target.talos.tests.zip 06:09:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:09:58 INFO - Fetch https://queue.taskcluster.net/v1/task/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/target.talos.tests.zip into memory 06:09:59 INFO - Content-Length response header: 14411859 06:09:59 INFO - Bytes received: 14411859 06:09:59 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')]} 06:09:59 INFO - trying https://queue.taskcluster.net/v1/task/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/target.tar.bz2 06:09:59 INFO - Downloading https://queue.taskcluster.net/v1/task/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:09:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:10:00 INFO - Downloaded 55569978 bytes. 06:10:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/target.tar.bz2 06:10:00 INFO - mkdir: /builds/slave/test/properties 06:10:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:10:00 INFO - Writing to file /builds/slave/test/properties/build_url 06:10:00 INFO - Contents: 06:10:00 INFO - build_url:https://queue.taskcluster.net/v1/task/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/target.tar.bz2 06:10:00 INFO - Running post-action listener: _resource_record_post_action 06:10:00 INFO - Running post-action listener: set_extra_try_arguments 06:10:00 INFO - [mozharness: 2017-05-25 13:10:00.751869Z] Finished download-and-extract step (success) 06:10:00 INFO - [mozharness: 2017-05-25 13:10:00.752031Z] Running populate-webroot step. 06:10:00 INFO - Running pre-action listener: _resource_record_pre_action 06:10:00 INFO - Running main action method: populate_webroot 06:10:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:10:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:10:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:10:00 INFO - '--tppagecycles', 06:10:00 INFO - '7'], 06:10:00 INFO - 'tests': ['tsvgm']}}, 06:10:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:10:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:10:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:10:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:10:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:10:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:10:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 06:10:00 INFO - 'talos_options': ['--disable-e10s'], 06:10:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:10:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:10:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:10:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 06:10:00 INFO - 'talos_options': ['--disable-e10s'], 06:10:00 INFO - 'tests': ['damp', 'tps']}, 06:10:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:10:00 INFO - 'tests': ['damp', 'tps']}, 06:10:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:10:00 INFO - 'tests': ['dromaeo_dom']}, 06:10:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:10:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:10:00 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 06:10:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:10:00 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:10:00 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:10:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:10:00 INFO - 'tests': ['a11yr', 06:10:00 INFO - 'ts_paint', 06:10:00 INFO - 'tpaint', 06:10:00 INFO - 'sessionrestore', 06:10:00 INFO - 'sessionrestore_no_auto_restore', 06:10:00 INFO - 'tabpaint']}, 06:10:00 INFO - 'other-e10s': {'tests': ['a11yr', 06:10:00 INFO - 'ts_paint', 06:10:00 INFO - 'tpaint', 06:10:00 INFO - 'sessionrestore', 06:10:00 INFO - 'sessionrestore_no_auto_restore', 06:10:00 INFO - 'tabpaint']}, 06:10:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:10:00 INFO - 'ts_paint', 06:10:00 INFO - 'tpaint', 06:10:00 INFO - 'sessionrestore', 06:10:00 INFO - 'sessionrestore_no_auto_restore', 06:10:00 INFO - 'tabpaint']}, 06:10:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:10:00 INFO - 'ts_paint', 06:10:00 INFO - 'tpaint', 06:10:00 INFO - 'sessionrestore', 06:10:00 INFO - 'sessionrestore_no_auto_restore', 06:10:00 INFO - 'tabpaint']}, 06:10:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:10:00 INFO - 'tests': ['a11yr', 06:10:00 INFO - 'ts_paint', 06:10:00 INFO - 'tpaint', 06:10:00 INFO - 'sessionrestore', 06:10:00 INFO - 'sessionrestore_no_auto_restore', 06:10:00 INFO - 'tabpaint']}, 06:10:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:10:00 INFO - 'tests': ['a11yr', 06:10:00 INFO - 'ts_paint', 06:10:00 INFO - 'tpaint', 06:10:00 INFO - 'sessionrestore', 06:10:00 INFO - 'sessionrestore_no_auto_restore', 06:10:00 INFO - 'tabpaint']}, 06:10:00 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 06:10:00 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 06:10:00 INFO - 'bloom_basic_ref']}, 06:10:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:10:00 INFO - 'tests': ['tsvgx', 06:10:00 INFO - 'tsvgr_opacity', 06:10:00 INFO - 'tart', 06:10:00 INFO - 'tscrollx', 06:10:00 INFO - 'cart', 06:10:00 INFO - 'tsvg_static']}, 06:10:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:10:00 INFO - 'tsvgr_opacity', 06:10:00 INFO - 'tart', 06:10:00 INFO - 'tscrollx', 06:10:00 INFO - 'cart', 06:10:00 INFO - 'tsvg_static']}, 06:10:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 06:10:00 INFO - 'talos_options': ['--disable-e10s'], 06:10:00 INFO - 'tests': ['tp5o']}, 06:10:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:10:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 06:10:00 INFO - 'talos_options': ['--disable-e10s', 06:10:00 INFO - '--xperf_path', 06:10:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:10:00 INFO - 'tests': ['tp5n']}, 06:10:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:10:00 INFO - 'talos_options': ['--xperf_path', 06:10:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:10:00 INFO - 'tests': ['tp5n']}}, 06:10:00 INFO - 'talos.zip': {'path': '', 06:10:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:10:00 INFO - Running post-action listener: _resource_record_post_action 06:10:00 INFO - [mozharness: 2017-05-25 13:10:00.772103Z] Finished populate-webroot step (success) 06:10:00 INFO - [mozharness: 2017-05-25 13:10:00.772192Z] Running create-virtualenv step. 06:10:00 INFO - Running pre-action listener: _resource_record_pre_action 06:10:00 INFO - Running main action method: create_virtualenv 06:10:00 INFO - Creating virtualenv /builds/slave/test/build/venv 06:10:00 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 06:10:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:10:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:10:00 INFO - Using real prefix '/usr' 06:10:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:10:01 INFO - Installing distribute.............................................................................................................................................................................................done. 06:10:03 INFO - Installing pip.................done. 06:10:03 INFO - Return code: 0 06:10:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:10:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:10:03 INFO - Reading from file tmpfile_stdout 06:10:03 INFO - Output received: 06:10:03 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) 06:10:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:10:03 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')]} 06:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:03 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')]} 06:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:03 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 0x10611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d17a0>, '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 0x13d26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d2b30>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920', '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 06:10:03 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 06:10:03 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 06:10:03 INFO - Using env: {'DISPLAY': ':0', 06:10:03 INFO - 'HOME': '/home/cltbld', 06:10:03 INFO - 'LANG': 'en_US.UTF-8', 06:10:03 INFO - 'LANGUAGE': 'en_US:en', 06:10:03 INFO - 'LOGNAME': 'cltbld', 06:10:03 INFO - 'MAIL': '/var/mail/cltbld', 06:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:03 INFO - 'MOZ_NO_REMOTE': '1', 06:10:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:03 INFO - 'NO_EM_RESTART': '1', 06:10:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:03 INFO - 'PWD': '/builds/slave/test', 06:10:03 INFO - 'SHELL': '/bin/bash', 06:10:03 INFO - 'SHLVL': '1', 06:10:03 INFO - 'TERM': 'linux', 06:10:03 INFO - 'TMOUT': '86400', 06:10:03 INFO - 'USER': 'cltbld', 06:10:03 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920', 06:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:03 INFO - '_': '/tools/buildbot/bin/python'} 06:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:03 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 06:10:03 INFO - Cleaning up... 06:10:03 INFO - Return code: 0 06:10:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:10:03 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')]} 06:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:03 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')]} 06:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:03 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 0x10611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d17a0>, '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 0x13d26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d2b30>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920', '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 06:10:03 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 06:10:03 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 06:10:03 INFO - Using env: {'DISPLAY': ':0', 06:10:03 INFO - 'HOME': '/home/cltbld', 06:10:03 INFO - 'LANG': 'en_US.UTF-8', 06:10:03 INFO - 'LANGUAGE': 'en_US:en', 06:10:03 INFO - 'LOGNAME': 'cltbld', 06:10:03 INFO - 'MAIL': '/var/mail/cltbld', 06:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:03 INFO - 'MOZ_NO_REMOTE': '1', 06:10:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:03 INFO - 'NO_EM_RESTART': '1', 06:10:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:03 INFO - 'PWD': '/builds/slave/test', 06:10:03 INFO - 'SHELL': '/bin/bash', 06:10:03 INFO - 'SHLVL': '1', 06:10:03 INFO - 'TERM': 'linux', 06:10:03 INFO - 'TMOUT': '86400', 06:10:03 INFO - 'USER': 'cltbld', 06:10:03 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920', 06:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:03 INFO - '_': '/tools/buildbot/bin/python'} 06:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:03 INFO - Downloading/unpacking psutil>=3.1.1 06:10:03 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 06:10:03 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 06:10:03 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 06:10:03 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 06:10:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:10:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:10:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:10:05 INFO - Installing collected packages: psutil 06:10:05 INFO - Running setup.py install for psutil 06:10:05 INFO - building 'psutil._psutil_linux' extension 06:10:05 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 06:10:05 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 06:10:05 INFO - building 'psutil._psutil_posix' extension 06:10:05 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 06:10:05 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 06:10:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:10:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:10:05 INFO - Successfully installed psutil 06:10:05 INFO - Cleaning up... 06:10:05 INFO - Return code: 0 06:10:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:10: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')]} 06:10:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10: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')]} 06:10:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d17a0>, '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 0x13d26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d2b30>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920', '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 06:10:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:10:05 INFO - Using env: {'DISPLAY': ':0', 06:10:05 INFO - 'HOME': '/home/cltbld', 06:10:05 INFO - 'LANG': 'en_US.UTF-8', 06:10:05 INFO - 'LANGUAGE': 'en_US:en', 06:10:05 INFO - 'LOGNAME': 'cltbld', 06:10:05 INFO - 'MAIL': '/var/mail/cltbld', 06:10:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:05 INFO - 'MOZ_NO_REMOTE': '1', 06:10:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:05 INFO - 'NO_EM_RESTART': '1', 06:10:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:05 INFO - 'PWD': '/builds/slave/test', 06:10:05 INFO - 'SHELL': '/bin/bash', 06:10:05 INFO - 'SHLVL': '1', 06:10:05 INFO - 'TERM': 'linux', 06:10:05 INFO - 'TMOUT': '86400', 06:10:05 INFO - 'USER': 'cltbld', 06:10:05 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920', 06:10:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:05 INFO - '_': '/tools/buildbot/bin/python'} 06:10:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:10:05 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 06:10:05 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 06:10:05 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 06:10:05 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 06:10:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:10:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:10:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:10:07 INFO - Installing collected packages: mozsystemmonitor 06:10:07 INFO - Running setup.py install for mozsystemmonitor 06:10:07 INFO - Successfully installed mozsystemmonitor 06:10:07 INFO - Cleaning up... 06:10:07 INFO - Return code: 0 06:10:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d17a0>, '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 0x13d26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d2b30>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920', '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 06:10:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:10:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:10:07 INFO - Using env: {'DISPLAY': ':0', 06:10:07 INFO - 'HOME': '/home/cltbld', 06:10:07 INFO - 'LANG': 'en_US.UTF-8', 06:10:07 INFO - 'LANGUAGE': 'en_US:en', 06:10:07 INFO - 'LOGNAME': 'cltbld', 06:10:07 INFO - 'MAIL': '/var/mail/cltbld', 06:10:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:07 INFO - 'MOZ_NO_REMOTE': '1', 06:10:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:07 INFO - 'NO_EM_RESTART': '1', 06:10:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:07 INFO - 'PWD': '/builds/slave/test', 06:10:07 INFO - 'SHELL': '/bin/bash', 06:10:07 INFO - 'SHLVL': '1', 06:10:07 INFO - 'TERM': 'linux', 06:10:07 INFO - 'TMOUT': '86400', 06:10:07 INFO - 'USER': 'cltbld', 06:10:07 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920', 06:10:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:07 INFO - '_': '/tools/buildbot/bin/python'} 06:10:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:07 INFO - Downloading/unpacking jsonschema==2.5.1 06:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:10:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:10:08 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 06:10:08 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 06:10:08 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 06:10:08 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 06:10:08 INFO - Downloading functools32-3.2.3-2.tar.gz 06:10:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:10:08 INFO - warning: no files found matching '*.txt' 06:10:08 INFO - no previously-included directories found matching 'build' 06:10:08 INFO - no previously-included directories found matching 'dist' 06:10:08 INFO - no previously-included directories found matching '.git*' 06:10:08 INFO - Installing collected packages: jsonschema, functools32 06:10:08 INFO - Running setup.py install for functools32 06:10:08 INFO - warning: no files found matching '*.txt' 06:10:08 INFO - no previously-included directories found matching 'build' 06:10:08 INFO - no previously-included directories found matching 'dist' 06:10:08 INFO - no previously-included directories found matching '.git*' 06:10:08 INFO - Successfully installed jsonschema functools32 06:10:08 INFO - Cleaning up... 06:10:08 INFO - Return code: 0 06:10:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:10:08 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')]} 06:10:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:08 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')]} 06:10:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:08 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 0x10611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d17a0>, '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 0x13d26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d2b30>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920', '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 06:10:08 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 06:10:08 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 06:10:08 INFO - Using env: {'DISPLAY': ':0', 06:10:08 INFO - 'HOME': '/home/cltbld', 06:10:08 INFO - 'LANG': 'en_US.UTF-8', 06:10:08 INFO - 'LANGUAGE': 'en_US:en', 06:10:08 INFO - 'LOGNAME': 'cltbld', 06:10:08 INFO - 'MAIL': '/var/mail/cltbld', 06:10:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:08 INFO - 'MOZ_NO_REMOTE': '1', 06:10:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:08 INFO - 'NO_EM_RESTART': '1', 06:10:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:08 INFO - 'PWD': '/builds/slave/test', 06:10:08 INFO - 'SHELL': '/bin/bash', 06:10:08 INFO - 'SHLVL': '1', 06:10:08 INFO - 'TERM': 'linux', 06:10:08 INFO - 'TMOUT': '86400', 06:10:08 INFO - 'USER': 'cltbld', 06:10:08 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920', 06:10:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:08 INFO - '_': '/tools/buildbot/bin/python'} 06:10:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:10:09 INFO - Cleaning up... 06:10:09 INFO - Return code: 0 06:10:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d17a0>, '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 0x13d26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d2b30>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920', '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 06:10:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:10:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:10:09 INFO - Using env: {'DISPLAY': ':0', 06:10:09 INFO - 'HOME': '/home/cltbld', 06:10:09 INFO - 'LANG': 'en_US.UTF-8', 06:10:09 INFO - 'LANGUAGE': 'en_US:en', 06:10:09 INFO - 'LOGNAME': 'cltbld', 06:10:09 INFO - 'MAIL': '/var/mail/cltbld', 06:10:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:09 INFO - 'MOZ_NO_REMOTE': '1', 06:10:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:09 INFO - 'NO_EM_RESTART': '1', 06:10:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:09 INFO - 'PWD': '/builds/slave/test', 06:10:09 INFO - 'SHELL': '/bin/bash', 06:10:09 INFO - 'SHLVL': '1', 06:10:09 INFO - 'TERM': 'linux', 06:10:09 INFO - 'TMOUT': '86400', 06:10:09 INFO - 'USER': 'cltbld', 06:10:09 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920', 06:10:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:09 INFO - '_': '/tools/buildbot/bin/python'} 06:10:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:09 INFO - Downloading/unpacking blobuploader==1.2.4 06:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:10 INFO - Downloading blobuploader-1.2.4.tar.gz 06:10:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:10:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:10:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:10 INFO - Downloading docopt-0.6.1.tar.gz 06:10:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:10:11 INFO - Installing collected packages: blobuploader, requests, docopt 06:10:11 INFO - Running setup.py install for blobuploader 06:10:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:10:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:10:11 INFO - Running setup.py install for requests 06:10:11 INFO - Running setup.py install for docopt 06:10:11 INFO - Successfully installed blobuploader requests docopt 06:10:11 INFO - Cleaning up... 06:10:11 INFO - Return code: 0 06:10:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:11 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 0x10611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d17a0>, '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 0x13d26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d2b30>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920', '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 06:10:11 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 06:10:11 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 06:10:11 INFO - Using env: {'DISPLAY': ':0', 06:10:11 INFO - 'HOME': '/home/cltbld', 06:10:11 INFO - 'LANG': 'en_US.UTF-8', 06:10:11 INFO - 'LANGUAGE': 'en_US:en', 06:10:11 INFO - 'LOGNAME': 'cltbld', 06:10:11 INFO - 'MAIL': '/var/mail/cltbld', 06:10:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:11 INFO - 'MOZ_NO_REMOTE': '1', 06:10:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:11 INFO - 'NO_EM_RESTART': '1', 06:10:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:11 INFO - 'PWD': '/builds/slave/test', 06:10:11 INFO - 'SHELL': '/bin/bash', 06:10:11 INFO - 'SHLVL': '1', 06:10:11 INFO - 'TERM': 'linux', 06:10:11 INFO - 'TMOUT': '86400', 06:10:11 INFO - 'USER': 'cltbld', 06:10:11 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920', 06:10:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:11 INFO - '_': '/tools/buildbot/bin/python'} 06:10:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:10:11 INFO - Running setup.py (path:/tmp/pip-TgkKth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:10:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:10:11 INFO - Running setup.py (path:/tmp/pip-yN_6_n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:10:12 INFO - Running setup.py (path:/tmp/pip-CrYIXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:10:12 INFO - Running setup.py (path:/tmp/pip-Lv0iJ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:10:12 INFO - Running setup.py (path:/tmp/pip-lNqSEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:10:12 INFO - Running setup.py (path:/tmp/pip-gZ9M99-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:10:12 INFO - Running setup.py (path:/tmp/pip-VBXIR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:10:12 INFO - Running setup.py (path:/tmp/pip-7FrYE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:10:12 INFO - Running setup.py (path:/tmp/pip-r7usx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:10:12 INFO - Running setup.py (path:/tmp/pip-qu1Zov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:10:12 INFO - Running setup.py (path:/tmp/pip-anBScx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:10:12 INFO - Running setup.py (path:/tmp/pip-uWB_Ux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:10:12 INFO - Running setup.py (path:/tmp/pip-ypCh06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:10:12 INFO - Running setup.py (path:/tmp/pip-4AvFlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:10:12 INFO - Running setup.py (path:/tmp/pip-5Kcl0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:10:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:10:12 INFO - Running setup.py (path:/tmp/pip-HqMMrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:10:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:10:13 INFO - Running setup.py (path:/tmp/pip-7GOxbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:10:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:10:13 INFO - Running setup.py install for manifestparser 06:10:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:10:13 INFO - Running setup.py install for mozcrash 06:10:13 INFO - Running setup.py install for mozdebug 06:10:13 INFO - Running setup.py install for mozdevice 06:10:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:10:13 INFO - Running setup.py install for mozfile 06:10:13 INFO - Running setup.py install for mozhttpd 06:10:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:10:13 INFO - Running setup.py install for mozinfo 06:10:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:10:13 INFO - Running setup.py install for mozInstall 06:10:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:10:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:10:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:10:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:10:13 INFO - Running setup.py install for mozleak 06:10:13 INFO - Running setup.py install for mozlog 06:10:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:10:14 INFO - Running setup.py install for moznetwork 06:10:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:10:14 INFO - Running setup.py install for mozprocess 06:10:14 INFO - Running setup.py install for mozprofile 06:10:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:10:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:10:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:10:14 INFO - Running setup.py install for mozrunner 06:10:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:10:14 INFO - Running setup.py install for mozscreenshot 06:10:14 INFO - Running setup.py install for moztest 06:10:14 INFO - Running setup.py install for mozversion 06:10:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:10:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:10:14 INFO - Cleaning up... 06:10:14 INFO - Return code: 0 06:10:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:14 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 0x10611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d17a0>, '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 0x13d26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d2b30>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920', '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 06:10:14 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 06:10:14 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 06:10:14 INFO - Using env: {'DISPLAY': ':0', 06:10:14 INFO - 'HOME': '/home/cltbld', 06:10:14 INFO - 'LANG': 'en_US.UTF-8', 06:10:14 INFO - 'LANGUAGE': 'en_US:en', 06:10:14 INFO - 'LOGNAME': 'cltbld', 06:10:14 INFO - 'MAIL': '/var/mail/cltbld', 06:10:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:14 INFO - 'MOZ_NO_REMOTE': '1', 06:10:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:14 INFO - 'NO_EM_RESTART': '1', 06:10:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:14 INFO - 'PWD': '/builds/slave/test', 06:10:14 INFO - 'SHELL': '/bin/bash', 06:10:14 INFO - 'SHLVL': '1', 06:10:14 INFO - 'TERM': 'linux', 06:10:14 INFO - 'TMOUT': '86400', 06:10:14 INFO - 'USER': 'cltbld', 06:10:14 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920', 06:10:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:14 INFO - '_': '/tools/buildbot/bin/python'} 06:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:10:15 INFO - Running setup.py (path:/tmp/pip-D9Wqkc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:10:15 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)) 06:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:10:15 INFO - Running setup.py (path:/tmp/pip-ZAwmFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:10:15 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)) 06:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:10:15 INFO - Running setup.py (path:/tmp/pip-1Ua_6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:10:15 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)) 06:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:10:15 INFO - Running setup.py (path:/tmp/pip-UhA6uH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:10:15 INFO - Running setup.py (path:/tmp/pip-ipWhOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:10:15 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)) 06:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:10:15 INFO - Running setup.py (path:/tmp/pip-8BqpMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:10:15 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)) 06:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:10:15 INFO - Running setup.py (path:/tmp/pip-jmQxWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:10:15 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)) 06:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:10:15 INFO - Running setup.py (path:/tmp/pip-cTyoSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:10:15 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)) 06:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:10:15 INFO - Running setup.py (path:/tmp/pip-XVQMdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:10:15 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)) 06:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:10:15 INFO - Running setup.py (path:/tmp/pip-KqutDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:10:15 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)) 06:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:10:15 INFO - Running setup.py (path:/tmp/pip-wZFHsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:10:15 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)) 06:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:10:15 INFO - Running setup.py (path:/tmp/pip-udkn2V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:10:15 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)) 06:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:10:15 INFO - Running setup.py (path:/tmp/pip-irza9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:10:16 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)) 06:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:10:16 INFO - Running setup.py (path:/tmp/pip-NpnSrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:10:16 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)) 06:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:10:16 INFO - Running setup.py (path:/tmp/pip-vOWFXS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:10:16 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)) 06:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:10:16 INFO - Running setup.py (path:/tmp/pip-7pkeMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:10:16 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)) 06:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:10:16 INFO - Running setup.py (path:/tmp/pip-UKBmIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:10:16 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)) 06:10:16 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)) 06:10:16 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)) 06:10:16 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)) 06:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:10:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:10:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:17 INFO - Downloading blessings-1.6.tar.gz 06:10:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:10:17 INFO - Installing collected packages: blessings 06:10:17 INFO - Running setup.py install for blessings 06:10:17 INFO - Successfully installed blessings 06:10:17 INFO - Cleaning up... 06:10:17 INFO - Return code: 0 06:10:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:10:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:10:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:10:17 INFO - Reading from file tmpfile_stdout 06:10:17 INFO - Current package versions: 06:10:17 INFO - argparse == 1.2.1 06:10:17 INFO - blessings == 1.6 06:10:17 INFO - blobuploader == 1.2.4 06:10:17 INFO - docopt == 0.6.1 06:10:17 INFO - functools32 == 3.2.3-2 06:10:17 INFO - jsonschema == 2.5.1 06:10:17 INFO - manifestparser == 1.1 06:10:17 INFO - mozInstall == 1.12 06:10:17 INFO - mozcrash == 1.0 06:10:17 INFO - mozdebug == 0.1 06:10:17 INFO - mozdevice == 0.51 06:10:17 INFO - mozfile == 1.2 06:10:17 INFO - mozhttpd == 0.7 06:10:17 INFO - mozinfo == 0.9 06:10:17 INFO - mozleak == 0.1 06:10:17 INFO - mozlog == 3.4 06:10:17 INFO - moznetwork == 0.27 06:10:17 INFO - mozprocess == 0.25 06:10:17 INFO - mozprofile == 0.28 06:10:17 INFO - mozrunner == 6.13 06:10:17 INFO - mozscreenshot == 0.1 06:10:17 INFO - mozsystemmonitor == 0.3 06:10:17 INFO - moztest == 0.8 06:10:17 INFO - mozversion == 1.4 06:10:17 INFO - psutil == 3.1.1 06:10:17 INFO - requests == 1.2.3 06:10:17 INFO - wsgiref == 0.1.2 06:10:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:17 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 0x10611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d17a0>, '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 0x13d26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d2b30>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920', '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 06:10:17 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 06:10:17 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 06:10:17 INFO - Using env: {'DISPLAY': ':0', 06:10:17 INFO - 'HOME': '/home/cltbld', 06:10:17 INFO - 'LANG': 'en_US.UTF-8', 06:10:17 INFO - 'LANGUAGE': 'en_US:en', 06:10:17 INFO - 'LOGNAME': 'cltbld', 06:10:17 INFO - 'MAIL': '/var/mail/cltbld', 06:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:17 INFO - 'MOZ_NO_REMOTE': '1', 06:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:17 INFO - 'NO_EM_RESTART': '1', 06:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:17 INFO - 'PWD': '/builds/slave/test', 06:10:17 INFO - 'SHELL': '/bin/bash', 06:10:17 INFO - 'SHLVL': '1', 06:10:17 INFO - 'TERM': 'linux', 06:10:17 INFO - 'TMOUT': '86400', 06:10:17 INFO - 'USER': 'cltbld', 06:10:17 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920', 06:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:17 INFO - '_': '/tools/buildbot/bin/python'} 06:10:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:18 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)) 06:10:18 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)) 06:10:18 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)) 06:10:18 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)) 06:10:18 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)) 06:10:18 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)) 06:10:18 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)) 06:10:18 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)) 06:10:18 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)) 06:10:18 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:10:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:10:19 INFO - Downloading marionette_driver-1.4.0.tar.gz 06:10:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 06:10:19 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)) 06:10:19 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)) 06:10:19 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)) 06:10:19 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)) 06:10:19 INFO - Installing collected packages: marionette-driver 06:10:19 INFO - Running setup.py install for marionette-driver 06:10:19 INFO - Successfully installed marionette-driver 06:10:19 INFO - Cleaning up... 06:10:19 INFO - Return code: 0 06:10:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:19 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 0x10611f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x122ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13d45c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13d17a0>, '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 0x13d26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d2b30>, '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': '88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920', '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 06:10:19 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 06:10:19 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 06:10:19 INFO - Using env: {'DISPLAY': ':0', 06:10:19 INFO - 'HOME': '/home/cltbld', 06:10:19 INFO - 'LANG': 'en_US.UTF-8', 06:10:19 INFO - 'LANGUAGE': 'en_US:en', 06:10:19 INFO - 'LOGNAME': 'cltbld', 06:10:19 INFO - 'MAIL': '/var/mail/cltbld', 06:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:19 INFO - 'MOZ_NO_REMOTE': '1', 06:10:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:19 INFO - 'NO_EM_RESTART': '1', 06:10:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:19 INFO - 'PWD': '/builds/slave/test', 06:10:19 INFO - 'SHELL': '/bin/bash', 06:10:19 INFO - 'SHLVL': '1', 06:10:19 INFO - 'TERM': 'linux', 06:10:19 INFO - 'TMOUT': '86400', 06:10:19 INFO - 'USER': 'cltbld', 06:10:19 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920', 06:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:19 INFO - '_': '/tools/buildbot/bin/python'} 06:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:10:19 INFO - Cleaning up... 06:10:19 INFO - Return code: 0 06:10:19 INFO - Running post-action listener: _resource_record_post_action 06:10:19 INFO - Running post-action listener: _start_resource_monitoring 06:10:19 INFO - Starting resource monitoring. 06:10:19 INFO - [mozharness: 2017-05-25 13:10:19.693299Z] Finished create-virtualenv step (success) 06:10:19 INFO - [mozharness: 2017-05-25 13:10:19.693977Z] Running install step. 06:10:19 INFO - Running pre-action listener: _resource_record_pre_action 06:10:19 INFO - Running main action method: install 06:10:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:10:19 INFO - Reading from file tmpfile_stdout 06:10:19 INFO - Detecting whether we're running mozinstall >=1.0... 06:10:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:10:19 INFO - Reading from file tmpfile_stdout 06:10:19 INFO - Output received: 06:10:19 INFO - Usage: mozinstall [options] installer 06:10:19 INFO - Options: 06:10:19 INFO - -h, --help show this help message and exit 06:10:19 INFO - -d DEST, --destination=DEST 06:10:19 INFO - Directory to install application into. [default: 06:10:19 INFO - "/builds/slave/test"] 06:10:19 INFO - --app=APP Application being installed. [default: firefox] 06:10:19 INFO - mkdir: /builds/slave/test/build/application 06:10:19 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'] 06:10:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:10:36 INFO - Reading from file tmpfile_stdout 06:10:36 INFO - Output received: 06:10:36 INFO - /builds/slave/test/build/application/firefox/firefox 06:10:36 INFO - Running post-action listener: _resource_record_post_action 06:10:36 INFO - [mozharness: 2017-05-25 13:10:36.012392Z] Finished install step (success) 06:10:36 INFO - [mozharness: 2017-05-25 13:10:36.012543Z] Running run-tests step. 06:10:36 INFO - Running pre-action listener: _resource_record_pre_action 06:10:36 INFO - Running main action method: run_tests 06:10:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:10:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:10:36 INFO - Python 2.7.3 06:10:36 INFO - Return code: 0 06:10:36 INFO - grabbing minidump binary from tooltool 06:10: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')]} 06:10:36 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 0x13d17a0>, '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 0x13d26a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13d2b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:10:36 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 06:10:36 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 06:10:36 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 06:10:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:10:36 INFO - Return code: 0 06:10:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:10:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:10:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:10:36 INFO - ENV: RUST_BACKTRACE is now 1 06:10:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:10:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:10:36 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/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 06:10:36 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/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-044 --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 06:10:36 INFO - Using env: {'DISPLAY': ':0', 06:10:36 INFO - 'HOME': '/home/cltbld', 06:10:36 INFO - 'LANG': 'en_US.UTF-8', 06:10:36 INFO - 'LANGUAGE': 'en_US:en', 06:10:36 INFO - 'LOGNAME': 'cltbld', 06:10:36 INFO - 'MAIL': '/var/mail/cltbld', 06:10:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:10:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:10:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:36 INFO - 'MOZ_NO_REMOTE': '1', 06:10:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:10:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:10:36 INFO - 'NO_EM_RESTART': '1', 06:10:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:10:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:36 INFO - 'PWD': '/builds/slave/test', 06:10:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:10:36 INFO - 'RUST_BACKTRACE': '1', 06:10:36 INFO - 'SHELL': '/bin/bash', 06:10:36 INFO - 'SHLVL': '1', 06:10:36 INFO - 'TERM': 'linux', 06:10:36 INFO - 'TMOUT': '86400', 06:10:36 INFO - 'USER': 'cltbld', 06:10:36 INFO - 'XDG_SESSION_COOKIE': '88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920', 06:10:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:36 INFO - '_': '/tools/buildbot/bin/python'} 06:10:36 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/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-044', '--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 06:10:36 INFO - mozversion application_buildid: 20170525122402 06:10:36 INFO - mozversion application_changeset: e8da7192201e5786614ec49d557e64dffd114ff2 06:10:36 INFO - mozversion application_display_name: Nightly 06:10:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:10:36 INFO - mozversion application_name: Firefox 06:10:36 INFO - mozversion application_remotingname: firefox 06:10:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 06:10:36 INFO - mozversion application_vendor: Mozilla 06:10:36 INFO - mozversion application_version: 55.0a1 06:10:36 INFO - mozversion platform_buildid: 20170525122402 06:10:36 INFO - mozversion platform_changeset: e8da7192201e5786614ec49d557e64dffd114ff2 06:10:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 06:10:36 INFO - mozversion platform_version: 55.0a1 06:10:36 INFO - using testdate: 1495717836 06:10:36 INFO - actual date: 1495717836 06:10:36 INFO - starting webserver on 'localhost:38001' 06:10:36 INFO - SUITE-START | Running 2 tests 06:10:36 INFO - TEST-START | dromaeo_css 06:10:36 INFO - operating with platform_type : linux_ 06:10:36 INFO - Initialising browser for dromaeo_css test... 06:10:36 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38001/getInfo.html -profile /tmp/tmp7uW08x/profile 06:10:36 INFO - TEST-INFO | started process 25864 (/builds/slave/test/build/application/firefox/firefox http://localhost:38001/getInfo.html) 06:11:11 INFO - TEST-INFO | 25864: killed by SIGTERM 06:11:11 INFO - Browser initialized. 06:11:11 INFO - Running cycle 1/1 for dromaeo_css test... 06:11:11 INFO - TEST-INFO | started process 26088 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7uW08x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:11:23 INFO - PID 26088 | RSS: Main: 176246784 06:11:23 INFO - PID 26088 | 06:14:27 INFO - PID 26088 | Cycle 1(1): loaded http://localhost:38001/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38001/tests/dromaeo/cssquery-ext.html) 06:14:29 INFO - PID 26088 | RSS: Main: 173600768 06:14:29 INFO - PID 26088 | 06:17:31 INFO - PID 26088 | Cycle 1(1): loaded http://localhost:38001/tests/dromaeo/cssquery-ext.html (next: http://localhost:38001/tests/dromaeo/cssquery-jquery.html) 06:17:31 INFO - PID 26088 | RSS: Main: 179286016 06:17:31 INFO - PID 26088 | 06:20:33 INFO - PID 26088 | Cycle 1(1): loaded http://localhost:38001/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38001/tests/dromaeo/cssquery-mootools.html) 06:20:34 INFO - PID 26088 | RSS: Main: 178233344 06:20:34 INFO - PID 26088 | 06:23:35 INFO - PID 26088 | Cycle 1(1): loaded http://localhost:38001/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38001/tests/dromaeo/cssquery-prototype.html) 06:23:36 INFO - PID 26088 | RSS: Main: 182366208 06:23:36 INFO - PID 26088 | 06:26:39 INFO - PID 26088 | Cycle 1(1): loaded http://localhost:38001/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38001/tests/dromaeo/cssquery-yui.html) 06:26:39 INFO - PID 26088 | RSS: Main: 180637696 06:26:39 INFO - PID 26088 | 06:29:41 INFO - PID 26088 | Cycle 1(1): loaded http://localhost:38001/tests/dromaeo/cssquery-yui.html (next: http://localhost:38001/tests/dromaeo/cssquery-dojo.html) 06:29:42 INFO - PID 26088 | RSS: Main: 178421760 06:29:42 INFO - PID 26088 | 06:29:42 INFO - PID 26088 | __start_tp_report 06:29:42 INFO - PID 26088 | _x_x_mozilla_page_load 06:29:42 INFO - PID 26088 | _x_x_mozilla_page_load_details 06:29:42 INFO - PID 26088 | |i|pagename|runs| 06:29:42 INFO - PID 26088 | |0;dojo.html;2720.428709970906;2724.9046283380085;2726.877290521926;2756.931076723082;2758.2828464599197;5291.153415453528;5336.332958380198;5345.518903298703;5346;5349.144136938091;5364.034473794715;5372.167314066316;5388.191771234317;5475.5072043516075;5495.780168793243;4755.334253204537;4799.7120172789655;4844.927326090112;4883.316335713003;4884.047610715912;4845.757712114398;4902.093112774148;4910.484399138093;4916.237983112624;4934.728589927553;4721.409823772028;4773.045390921795;4798.808047678089;4840.709557426566;4898.24077268024;4705.647076469244;4752.904941901143;4800.1119792838435;4806.231003039532;4808.855734327975;4778.450478195017;4804.543568361;4811.374521312207;4813.08551375241;4865.610751139936;5311.760970756325;5383.380911195223;5386.461353864622;5393.325834270716;5401.054815407288;5719.084946408596;5806.883862322772;5826.941730582682;5892.175095486636;5920.703964801743;5942.405759424023;5947.524198064188;5949.315828679714;5950.434708702666;5955.672438015908;5489.670619762827;5493.340799104133;5499.7250137492965;5502.532284755761;5505.03661859173;5758.424157584292;5833.416658334218;5851.444112809277;6068.241469816273;6072.574919755663;5681.488666020078;5747.597668163272;5754.913676294859;5776.971115144397;5790;5766.884662306814;5839.211706419579;5882.529397648178;5886.23478947734;5890;5705.600607957404;5794.8551286217335;5799.884002320015;5809.477147056785;5836.212111364996;5807.448292412214;5881.676507792113;5884.852878678067;5888.705564721747;5895.086261629454;4845.466998630148;4850.272459131088;4857.53853383928;4861.270809378621;4900.681455705368;4137.482814648169;4150.439690641785;4159.043420013414;4159.875203743893;4192.664586833046;4743.66794324394;4812.133815913099;4836.516348365206;4921.680090794087;4922.483139270396;5828.79599214034;5829.59192856496;5831.795887144014;5836.8540786479825;5887.028640274307;4854.077725232195;4862.756862156878;4866.732329721828;4867.513248675175;4909.0672772173175;4983.103041452573;5061.468545802712;5117.257997590328;5120.129577971754;5193.740312984336;5437.483439073281;5443.918341224806;5457.781688732406;5471.8084867029465;5479.835604931858;5672.659640421588;5762.366139724711;5763;5829.38791426911;5841.32824725145;5325.281087053353;5331.1470164773455;5443.564514838724;5449.509544141047;5463.972680136574;5785.595008349375;5788.53691704671;5789.8263052108505;5809.070548712186;5810.680412577349;5675.035244008611;5750.856228594319;5751.511121554715;5839.124131380327;5908.881822363614;5679.432056794288;5701.657900525982;5718.1136923776885;5726.7709291629535;5757.453041961007;5695.117256825199;5712.42875712442;5713.657180569179;5717.285339332583;5721.084626459747;5470.480304371078;5565.220869078414;5581.804636837691;5585.860353491033;5627.043402621646;5618.831435056954;5687.402822703557;5696;5707.514861236676;5726.169705392612;5601.383847776823;5607;5616.129499927354;5617.606767526234;5619.775208991595 06:29:42 INFO - PID 26088 | |1;ext.html;672.3646154384109;688.246370224604;713.4007433755646;1151.7351009267863;1192.0761409907327;33954.66045339549;34981.30037399257;34996.475052874164;35011.2997740045;35259.47110793337;32439.837800811023;32859.835700821524;32881.17797055075;32889.50665740016;32980.175495612624;6158.815235542918;6246.500279977591;6247.281562620288;6369.936300637004;6410.583312084723;6740.325967403245;6817.590944543318;6841.17905851296;6845.31546845314;6849.1438570178725;6744.4941629377745;6773.4242589379965;6850.862982740342;6852.109225800639;6879.724811007553;6781.186257649064;6788.253292137861;6804.421624161952;6849.897251541206;6860.3825655690725;6627.86744265112;6653.93346066538;6672.199336079653;6685.39831415175;6688.264290927994;31280;31324.686753132406;31361.215969600715;31453.685463145306;31509.684903150905;3057.969420305813;3060.8469576521084;3081.6147981502313;3086.5833112529745;3097;24302.635460468107;24318.878405608037;24429.26712198637;24447.26658200257;24476.388090297707;2885.6825749167574;2901;2907.854607269649;2943.4848901442374;2949.1594895454905;142056;142567.28716356456;143487.28256358756;152813;154799.2260038704;39078.804605977355;39249.21501569953;39476.80261598674;39492;39532.604673953465;40145.1970960585;40459.59540404617;40515.39226911599;40520;43009.35485967713;12280.877191227974;12387.256764594153;12402.441890114966;12434.253944763343;12440.502379904883;9854.260930430246;9886.950565247127;9892.703218903445;9932.404055756677;9963.202943764481;12824.358782061046;12924.41840117197;12945.575986641463;12956;12971.805422918664;5233.215017747369;5248;5303.628745987744;5412.404635490093;5447.264619276347;856.3748463621591;881.9250363719156;888.1473785166313;895.5119459894373;920.1672486399818;19866.801331986495;20437.38687839367;20968;20979;21269.68095478569;962.8796400449944;964.1611797736015;976.2629214942815;985.3250523391499;993.7614972406715;10389.220808439397;11034;11086.778264434666;11124.61063862761;11164.832527512093;181276;181395;181499;181881;182766;40852.18295634071;40861.59138408637;40866.79566602207;41050.38424423636;41195.7940210297;1179.6940776826495;1217.2939694976892;1220.2617416462913;1224.9448774804978;1245.414655112096;19373.612527749647;19905.900470498134;20546.58906821885;20623.175072996914;21014.474638133557;29162;36020.81989590035;37152.81423592865;37195;37202.8139859299;162562.1871890633;163729;163736.18131909263;164194;164405;30203.244918877204;30320;30532.236694082825;30619.693803061684;30782.076537703906;35333;35473.645263547034;35892.82053589715;35994.8200258997;36064.81967590145;27165.370077795396;27873.44253114967;27963.580546291414;28119.297017574725;28763.42473150567;27210;27755.306117347227;28587.571186432637;29020.854895726232;30648;33427.164320892174;34082.488762669076;34312.48531271983;34470.48294275638;34622.82688586541;31978.20054498656;32742.50886236661;33196.33607327888;33791.83104084464;33942.66057339494;26020;27729.861350693118;28140.71859281381;28289.57565636476;28335.43329133447 06:29:42 INFO - PID 26088 | |2;jquery.html;396.2332885865848;401.161572313864;417.65543426673;419.6978175713486;431.92009478246524;16863.49409517715;17140.571485712833;17599.472015839514;17615.999999999985;18032.90983545084;17948;18128.274869005258;18143.546411339725;18178.181981810816;18193.18130684119;5289.206619007141;5502.724863756796;5506.614536982413;5524.58565607579;5528.889422211573;5187.740612969355;5479;5505.229267902497;5516.668999860021;5530.308711411074;5460.290162278899;5465.890682186354;5482.2873026506495;5499.065158922973;5503.807366742165;5392.1911713243135;5420.105682562373;5538.861528461781;5573.386927437979;5582.804601838916;5019.824306149304;5023.8492845214705;5024.145895197788;5047.293378926953;5068.847934561933;20977.26579569723;21210.25764098249;21233.46916327089;21415.250466233763;21625.134994600197;1613.790207273047;1637.0832333892938;1651.3312108596037;1659.037758100299;1659.444086231114;14454.855451445455;14778.408863645442;14902.925485372503;14908.925455372653;15249.771253431207;2053.147943603403;2111.535462198314;2123.851330406872;2131.7868213178713;2148;89001.53978443024;89923.55038224833;91101;91649;93810;10908.290961087503;11006.339619622848;11017.889821101686;11187.944060279646;11445.08439324852;15358.616034599225;15438.614034649;15458.84541154574;15468.690626187414;15486.690266194613;7905.762827115196;7928.8810667840025;8046.798830029179;8064.879026814602;8193.262606365455;7249.673764680602;7324.743633972892;7353.8161545961775;7497.850042999218;7554.169041405441;6754.223264324567;6970.222593238793;6997.475189360818;7016.54676617664;7091.361777440055;2045.8670186437835;2077.418322869599;2079.7296351474515;2095.790420957892;2241.2715867343177;839.3620848155446;879.6261588824851;883.3551507399634;890.3767362846033;901.0628945896326;16179;16412.09733464671;16581.91709041447;17097.743533847002;17206.483805485856;856.8286342731354;871.4814685262259;873.7990262239721;882.3073886998675;884.0408157149436;8867.201951824367;9315.115064068903;9400.48297343639;9418.670346537838;9535.284853636005;357387;361458;362836;366449;369854;72084;72529;73271.63364183145;73830;76282;1039.859618951447;1055.1716902231865;1062.6918193723889;1064.7018834726134;1071.0467683761458;14504.927475362556;14542.41830326775;14605.269736513344;14606.853931460975;15412.075275483507;37442.25115497729;37721.43417848789;38389.80805095957;39401.40897886477;39471.802640986614;46679;47799.5220047809;47844.76077619589;48716.26925596048;49377;7530.246975302426;7599.962000190185;7684.193159718149;7730.806729831575;7765.22347765219;11655.358955257543;11812.881871181178;12041.879581204075;12051.457684404048;12166.540015198232;10390.376577405379;10537.315074520131;10568.630097946843;10593.311434757024;10947.522084518489;9589.712308630753;9663.710088697351;9753.609855605697;9790.85313720309;9882.50587470638;10744.247902646739;10833.508293092475;10882.347059176474;10886.564537418732;11062.170337224901;7806.648700808364;7926.881096783438;8073.273405393308;8095.150009248944;8113.594320283844;10213.489325533545;10358;10651.520681569504;10677.519511622151;10843.728906777395 06:29:42 INFO - PID 26088 | |3;mootools.html;1241.3358853013638;1293.3662505372358;1296.6952766099964;1318.8549259581448;1319.610714839123;10528.631497897575;10999.395033273167;11125.054370378528;11130.721731956704;11340.489677964491;11113.499892504837;11306.378149201812;11325.263857849233;11329.206955513117;11340.546378144885;2246.0903334149693;2309.976900230993;2312.4912519245822;2313.9421514462188;2319.165100563804;2207.23850271656;2237.2057919438607;2246.7753224677563;2251.3921241264848;2252.234240358278;2212.796427701229;2226.14293497004;2237.1722462688826;2246.7753224677563;2249.392663980724;2130.573885222946;2172.6958225848393;2175.086463685256;2175.793299636532;2176.5864485747657;2161.4812445013085;2170.696102545645;2179.1283486605325;2266.8866556672265;2288.7139107611547;10831.2959657622;10921.672349829518;10962.177836662202;10968.780624387467;10971.670849874517;5626.2685850839125;5865.941340586583;5883.911741323884;5900.586958912878;5905.055191169436;3239.2225865792275;3327.2680010397917;3401.9659803401896;3423.5207071010077;3442.6729460701195;1074.1943542343242;1074.462768615692;1079.2768844873954;1110.4114819145866;1126.6788965144895;16125.677486450322;16254.674906501921;16264.837351626451;16269.593260168473;16281.430149944814;4669.859904202812;4857.684250523705;4920.3111564381015;4938.160512712848;4988.301637770715;11020.724481888017;11049.613263535737;11057.889421105687;11064.557417703363;11087.33475991443;5672.914906276409;5785.334686511021;5800.158976948319;5802.33273173582;5804.100364443518;5287.9735601321745;5341.626086174008;5342.519173274346;5375.838724838261;5409.540189083893;3828.789416582059;3919.8040097994985;3956.090099277182;4036.616521430459;4055.330870406409;1052.884182739898;1091.8689757229183;1106.5241945963312;1108.4623957380663;1114.6043154680135;632.3771085480797;654.5450911616476;672.2672287206968;680.6630717794625;687.7620283489698;5087.287779710843;5208.557272631869;5298.788048478094;5302.92045619316;5422.240886275925;543.6873797566415;559.7481133489946;563.9887202255932;564.5568228940263;576.5358886096733;3340.983295083509;3408.2672225471642;3426.7087297579487;3490.9650903491147;3828.770273783526;12724.109312348046;12943.482260709467;12980.415881285177;12984.415701293465;13607;12266.81599776004;12844.293563853891;12888.742225155633;14022.088564243291;14182.290885455892;7727.111382191008;7783.0660320760735;7798.064232292161;7848.254415830487;7860.292573668397;5556.805511807067;5597.104463285855;5610.18652295423;5738.340090889435;5883.61756485827;12433.440495177558;12732.554360597334;12752.6811829705;12908.290044047668;13066.869331306565;12791.744165116459;12950.093493455368;13100.672483187996;13114.672133196746;13371.531996380469;7546.094468663796;7832.216778322122;8233.958830205811;8686.695965641173;8719.694810681849;10547.683569492927;10551.103156231806;10558.472076396303;10574.471276436301;10616;8316.5425901576;8353.83292334162;8432.873506897524;8481.575921203792;8624.059586593217;8373.62318695648;8381.664733410595;8536;8666.35002374837;8789.912100879164;6795.762148324785;6864.313568643096;6878.037074809431;6879.346462086094;6966.12923384577;4972.378452693413;5024.0956627807345;5107.514786095315;5145.691258524501;5231.084560202025;5252.369715634149;5298.304542546348;5301.469853014668;5310.3893052297935;5414.538074719882 06:29:42 INFO - PID 26088 | |4;prototype.html;372.9981350093249;374.9681277091447;376.8266597365212;377.2360969037698;386.62497377543775;5471.79620483493;5557.888422315538;5586.83239502815;5590.301212348451;5635.718214089299;5388.595855310858;5457.890842183154;5473.31583552056;5534.723263836812;5548.223248745179;4050.6961977851633;4139.958600414003;4167.166566686659;4183.330667093273;4187.20443115807;4185.560516145806;4188.643965262956;4196.916061678765;4198.244316023115;4206.200821843855;4144.647704945083;4146.958530414702;4159.500859896817;4168.895777605554;4182.853600123996;4108.8356465741335;4149.962509372657;4162.979185104085;4167.374893765929;4170.4369910062205;3645.981770091159;3652.5982141964364;3653.0867283179205;3654.086478380405;3657.9268414631824;5392.487713667196;5404.919016196776;5407.37669292753;5408.134698448269;5411.702356370398;4675.555822196886;4850.102730994778;4853.927191092136;4866.732329721864;4884.877878053042;5800.303963524362;5814.534837213013;5831.620944638585;5849.151872978437;5869.207656966298;4031.637152656275;4066.3900414937702;4071.7149799514045;4075.3071977763852;4077.857274995361;6009.308929473123;6192.442680158807;6193.274959018017;6247.312795592436;6277.121203031534;4095.5494895561465;4099.446574712376;4113.691473139526;4127.504699436087;4138.358554424069;4140.60664236897;4149.356849688304;4176;4183.97908010458;4184.184084103571;4714.693544919569;4839.153148199051;4845.6123510119105;4860.92708609364;4861.781219845116;5868.767558812697;5880.558958078162;5904.586678932434;5911.674857882772;5924.140999555127;1440.942362305496;1451.4484495891493;1457.1475686723174;1464.5313499680212;1466.5893549806071;933.1135421349745;959.3476436023432;980.887197972228;985.0789511806483;986.8322385194534;4999.625028122832;5015.122353588107;5021.59827213822;5023.296738456619;5031.924521132186;6022.9044249910485;6031.828541724975;6033.66021071355;6066.817995460143;6071.696415179312;4835.637327200474;4970.701757894538;4983.750812459362;5001.9499805002215;5002.499750024968;3182.870081121169;3213.293075523381;3214.4856822908223;3231.4668079767043;3231.579894613685;5518.117101263779;5644.520215781705;5648.152777083388;5652.74562644682;5658.660480371191;6055.515558755289;6195.659238741822;6231.9688401557705;6289.842753931189;6314.179156709598;5639.351474580394;5640.8871822563315;5653.381835625203;5659.434056594308;5660.179274005329;5981.3719559445635;6064.666443345658;6071.662409972104;6106.389361063858;6113.14415981754;5710.971445142748;5966.701664916824;6011.7595296187665;6018.3981601841215;6062.909056364247;5595.901536923654;5610.691411972218;5628.915566266427;5641.464060914206;5671.829845104653;4072.511298644182;4129.442525259052;4148.979255103705;4155.542890282006;4165.375193720966;6100.26796784371;6130.41761032719;6131.570790044654;6132.509399248139;6133.202683651275;5857.7949771757785;5860.179574859609;5876.1773351731645;5897.528197744256;5900.11498275245;5725.341585717696;5769.971150144391;5864.44287792659;5885.911711324248;5887.146363777314;5810.82567522975;5819.82540523785;5824.184614154106;5826.679532625746;5829.717462158318;5800.564957628279;5891.469767720926;5923.259592550931;5956.076808094752;5956.285245770535;5705.743241554057;5722.341930677859;5735.340435849931;5739.856503587277;5762.1068734346245 06:29:42 INFO - PID 26088 | |5;yui.html;620.3765215957962;631.8894193516134;634.4226753654174;715.5563550598627;753.6307209467362;13761.967852411059;14176.078554893938;14225.075370100936;15362.923185384057;16426.75359869603;15641.608959776011;15658.295376708047;15660.84339156608;15777.921110394433;15796.526104216864;904.8778414913985;908.2643059122099;914.2457472585111;914.3782228084899;923.353652443289;870.6996086350199;894.838928992781;907.0385391485047;920.8066306075732;922.1101636920371;957.5978089202517;960.433344326847;962.6438217859402;964.662368171138;967.6371360739722;959.1415682963708;960.5149399553251;961.1109723505764;962.5957098018849;962.7785609309898;705.5696025424487;705.9576425414491;706.9646517674147;707.7735124760079;707.9539829911091;13233.206007639476;13270.867291327157;13360.599182024554;13380.397882095329;13423.194608323434;15760.68478630421;16461.58846028847;16477;16589.6682066358;16602.50192494227;11988.681245063037;12180;12410.689732756662;12491.625251242478;12519.12366134371;3034.4841376965746;3045.4822680144207;3048.6341639003463;3049.9390012199633;3065.1417603071177;82490;82688.9999999994;82750;82774;83651.5817420909;12135.878641213474;12215;12308.076894232969;12383.442745076492;12458.439370228361;22544.887275563844;23600.881995589913;23672;23764.7623523766;23779;6217.347178546278;6303.527235457359;6329.9872020476505;6350.714217860207;6370.8088757337355;2958.9704102958694;3021.8035827671133;3041.9543706843974;3051.61854768154;3066.1414803854955;3616;3659.341318562684;3686.4838922550866;3688.3914154164263;3697.7966211858607;673.5016088094775;682.1336902134261;686.4371215603257;689.9103116594811;690.5925503952692;578.6036564953021;593.6527131628046;601.0923505506717;605.1104875832519;610.5359926455836;9664.420134791935;9728.221742260603;10171.389716617026;10176;10763.515641796137;566.0405612486795;568.6019786149711;592.8962431574457;597.2295738497377;600.2886579403421;4394.956050439455;4563;4597.126545956257;4607.216773148572;4624.5144259852905;84118;85062.57468712617;85232;87237.5638121818;88090.55954720185;70175.64912175406;71571.64214179;71721;72182.63908680528;74065.25934740584;63119.684401577695;63431.6828415855;63477.68261158665;65180.348196518375;66013.33986660071;9042.095790421168;9044.186023257938;9051.094890510896;9142.542872856464;9391.107844754737;26750.732492674822;26796.732032680204;27648.861755691094;27847.44305113846;28165.15504534867;47611.761941190074;48990.265146022124;49047.50952490572;49324;50301.496985031146;14153.858461415666;14302.642433939234;14408.13551186932;14606.926965365104;14714.411423542939;15224.46714364992;15394.615134621725;15399.384024638888;15655.21723913777;15675.216239188223;14618.41526338977;15132.167730774472;15142.697146057237;15234;15256.466023689118;14696.706065878836;14702.338394772047;14925.402983880524;15073.623159420664;15074.397024118913;13772.931135344259;14282.714345713235;14343.426262949783;14384.424623014962;14629.195394253418;9835.803283934425;10239.795204095728;10268.948655256676;10400.323978941344;10510.421926793793;10478.63324783629;10991.780164396827;11480.770384592428;12042.277463352228;12165.513379464723 06:29:42 INFO - PID 26088 | __end_tp_report 06:29:42 INFO - PID 26088 | __start_cc_report 06:29:42 INFO - PID 26088 | _x_x_mozilla_cycle_collect,333 06:29:42 INFO - PID 26088 | __end_cc_report 06:29:42 INFO - PID 26088 | __startTimestamp1495718982021__endTimestamp 06:29:42 INFO - PID 26088 | 06:29:42 INFO - PID 26088 | ------- Summary: start ------- 06:29:42 INFO - PID 26088 | Number of tests: 6 06:29:42 INFO - PID 26088 | 06:29:42 INFO - PID 26088 | [#0] dojo.html Cycles:165 Average:5322.68 Median:5495.78 stddev:643.76 (11.7%) stddev-sans-first:612.52 06:29:42 INFO - PID 26088 | Values: 2720.4 2724.9 2726.9 2756.9 2758.3 5291.2 5336.3 5345.5 5346.0 5349.1 5364.0 5372.2 5388.2 5475.5 5495.8 4755.3 4799.7 4844.9 4883.3 4884.0 4845.8 4902.1 4910.5 4916.2 4934.7 4721.4 4773.0 4798.8 4840.7 4898.2 4705.6 4752.9 4800.1 4806.2 4808.9 4778.5 4804.5 4811.4 4813.1 4865.6 5311.8 5383.4 5386.5 5393.3 5401.1 5719.1 5806.9 5826.9 5892.2 5920.7 5942.4 5947.5 5949.3 5950.4 5955.7 5489.7 5493.3 5499.7 5502.5 5505.0 5758.4 5833.4 5851.4 6068.2 6072.6 5681.5 5747.6 5754.9 5777.0 5790.0 5766.9 5839.2 5882.5 5886.2 5890.0 5705.6 5794.9 5799.9 5809.5 5836.2 5807.4 5881.7 5884.9 5888.7 5895.1 4845.5 4850.3 4857.5 4861.3 4900.7 4137.5 4150.4 4159.0 4159.9 4192.7 4743.7 4812.1 4836.5 4921.7 4922.5 5828.8 5829.6 5831.8 5836.9 5887.0 4854.1 4862.8 4866.7 4867.5 4909.1 4983.1 5061.5 5117.3 5120.1 5193.7 5437.5 5443.9 5457.8 5471.8 5479.8 5672.7 5762.4 5763.0 5829.4 5841.3 5325.3 5331.1 5443.6 5449.5 5464.0 5785.6 5788.5 5789.8 5809.1 5810.7 5675.0 5750.9 5751.5 5839.1 5908.9 5679.4 5701.7 5718.1 5726.8 5757.5 5695.1 5712.4 5713.7 5717.3 5721.1 5470.5 5565.2 5581.8 5585.9 5627.0 5618.8 5687.4 5696.0 5707.5 5726.2 5601.4 5607.0 5616.1 5617.6 5619.8 06:29:42 INFO - PID 26088 | 06:29:42 INFO - PID 26088 | [#1] ext.html Cycles:180 Average:31289.64 Median:32801.17 stddev:42550.25 (129.7%) stddev-sans-first:42607.51 06:29:42 INFO - PID 26088 | Values: 672.4 688.2 713.4 1151.7 1192.1 33954.7 34981.3 34996.5 35011.3 35259.5 32439.8 32859.8 32881.2 32889.5 32980.2 6158.8 6246.5 6247.3 6369.9 6410.6 6740.3 6817.6 6841.2 6845.3 6849.1 6744.5 6773.4 6850.9 6852.1 6879.7 6781.2 6788.3 6804.4 6849.9 6860.4 6627.9 6653.9 6672.2 6685.4 6688.3 31280.0 31324.7 31361.2 31453.7 31509.7 3058.0 3060.8 3081.6 3086.6 3097.0 24302.6 24318.9 24429.3 24447.3 24476.4 2885.7 2901.0 2907.9 2943.5 2949.2 142056.0 142567.3 143487.3 152813.0 154799.2 39078.8 39249.2 39476.8 39492.0 39532.6 40145.2 40459.6 40515.4 40520.0 43009.4 12280.9 12387.3 12402.4 12434.3 12440.5 9854.3 9887.0 9892.7 9932.4 9963.2 12824.4 12924.4 12945.6 12956.0 12971.8 5233.2 5248.0 5303.6 5412.4 5447.3 856.4 881.9 888.1 895.5 920.2 19866.8 20437.4 20968.0 20979.0 21269.7 962.9 964.2 976.3 985.3 993.8 10389.2 11034.0 11086.8 11124.6 11164.8 181276.0 181395.0 181499.0 181881.0 182766.0 40852.2 40861.6 40866.8 41050.4 41195.8 1179.7 1217.3 1220.3 1224.9 1245.4 19373.6 19905.9 20546.6 20623.2 21014.5 29162.0 36020.8 37152.8 37195.0 37202.8 162562.2 163729.0 163736.2 164194.0 164405.0 30203.2 30320.0 30532.2 30619.7 30782.1 35333.0 35473.6 35892.8 35994.8 36064.8 27165.4 27873.4 27963.6 28119.3 28763.4 27210.0 27755.3 28587.6 29020.9 30648.0 33427.2 34082.5 34312.5 34470.5 34622.8 31978.2 32742.5 33196.3 33791.8 33942.7 26020.0 27729.9 28140.7 28289.6 28335.4 06:29:42 INFO - PID 26088 | 06:29:42 INFO - PID 26088 | [#2] jquery.html Cycles:180 Average:24490.95 Median:398.70 stddev:60589.50 (15196.9%) stddev-sans-first:60732.46 06:29:42 INFO - PID 26088 | Values: 396.2 401.2 417.7 419.7 431.9 16863.5 17140.6 17599.5 17616.0 18032.9 17948.0 18128.3 18143.5 18178.2 18193.2 5289.2 5502.7 5506.6 5524.6 5528.9 5187.7 5479.0 5505.2 5516.7 5530.3 5460.3 5465.9 5482.3 5499.1 5503.8 5392.2 5420.1 5538.9 5573.4 5582.8 5019.8 5023.8 5024.1 5047.3 5068.8 20977.3 21210.3 21233.5 21415.3 21625.1 1613.8 1637.1 1651.3 1659.0 1659.4 14454.9 14778.4 14902.9 14908.9 15249.8 2053.1 2111.5 2123.9 2131.8 2148.0 89001.5 89923.6 91101.0 91649.0 93810.0 10908.3 11006.3 11017.9 11187.9 11445.1 15358.6 15438.6 15458.8 15468.7 15486.7 7905.8 7928.9 8046.8 8064.9 8193.3 7249.7 7324.7 7353.8 7497.9 7554.2 6754.2 6970.2 6997.5 7016.5 7091.4 2045.9 2077.4 2079.7 2095.8 2241.3 839.4 879.6 883.4 890.4 901.1 16179.0 16412.1 16581.9 17097.7 17206.5 856.8 871.5 873.8 882.3 884.0 8867.2 9315.1 9400.5 9418.7 9535.3 357387.0 361458.0 362836.0 366449.0 369854.0 72084.0 72529.0 73271.6 73830.0 76282.0 1039.9 1055.2 1062.7 1064.7 1071.0 14504.9 14542.4 14605.3 14606.9 15412.1 37442.3 37721.4 38389.8 39401.4 39471.8 46679.0 47799.5 47844.8 48716.3 49377.0 7530.2 7600.0 7684.2 7730.8 7765.2 11655.4 11812.9 12041.9 12051.5 12166.5 10390.4 10537.3 10568.6 10593.3 10947.5 9589.7 9663.7 9753.6 9790.9 9882.5 10744.2 10833.5 10882.3 10886.6 11062.2 7806.6 7926.9 8073.3 8095.2 8113.6 10213.5 10358.0 10651.5 10677.5 10843.7 06:29:42 INFO - PID 26088 | 06:29:42 INFO - PID 26088 | [#3] mootools.html Cycles:180 Average:6471.90 Median:3283.25 stddev:4299.05 (130.9%) stddev-sans-first:4293.15 06:29:42 INFO - PID 26088 | Values: 1241.3 1293.4 1296.7 1318.9 1319.6 10528.6 10999.4 11125.1 11130.7 11340.5 11113.5 11306.4 11325.3 11329.2 11340.5 2246.1 2310.0 2312.5 2313.9 2319.2 2207.2 2237.2 2246.8 2251.4 2252.2 2212.8 2226.1 2237.2 2246.8 2249.4 2130.6 2172.7 2175.1 2175.8 2176.6 2161.5 2170.7 2179.1 2266.9 2288.7 10831.3 10921.7 10962.2 10968.8 10971.7 5626.3 5865.9 5883.9 5900.6 5905.1 3239.2 3327.3 3402.0 3423.5 3442.7 1074.2 1074.5 1079.3 1110.4 1126.7 16125.7 16254.7 16264.8 16269.6 16281.4 4669.9 4857.7 4920.3 4938.2 4988.3 11020.7 11049.6 11057.9 11064.6 11087.3 5672.9 5785.3 5800.2 5802.3 5804.1 5288.0 5341.6 5342.5 5375.8 5409.5 3828.8 3919.8 3956.1 4036.6 4055.3 1052.9 1091.9 1106.5 1108.5 1114.6 632.4 654.5 672.3 680.7 687.8 5087.3 5208.6 5298.8 5302.9 5422.2 543.7 559.7 564.0 564.6 576.5 3341.0 3408.3 3426.7 3491.0 3828.8 12724.1 12943.5 12980.4 12984.4 13607.0 12266.8 12844.3 12888.7 14022.1 14182.3 7727.1 7783.1 7798.1 7848.3 7860.3 5556.8 5597.1 5610.2 5738.3 5883.6 12433.4 12732.6 12752.7 12908.3 13066.9 12791.7 12950.1 13100.7 13114.7 13371.5 7546.1 7832.2 8234.0 8686.7 8719.7 10547.7 10551.1 10558.5 10574.5 10616.0 8316.5 8353.8 8432.9 8481.6 8624.1 8373.6 8381.7 8536.0 8666.4 8789.9 6795.8 6864.3 6878.0 6879.3 6966.1 4972.4 5024.1 5107.5 5145.7 5231.1 5252.4 5298.3 5301.5 5310.4 5414.5 06:29:42 INFO - PID 26088 | 06:29:42 INFO - PID 26088 | [#4] prototype.html Cycles:180 Average:4813.38 Median:5541.47 stddev:1439.39 (26.0%) stddev-sans-first:1404.31 06:29:42 INFO - PID 26088 | Values: 373.0 375.0 376.8 377.2 386.6 5471.8 5557.9 5586.8 5590.3 5635.7 5388.6 5457.9 5473.3 5534.7 5548.2 4050.7 4140.0 4167.2 4183.3 4187.2 4185.6 4188.6 4196.9 4198.2 4206.2 4144.6 4147.0 4159.5 4168.9 4182.9 4108.8 4150.0 4163.0 4167.4 4170.4 3646.0 3652.6 3653.1 3654.1 3657.9 5392.5 5404.9 5407.4 5408.1 5411.7 4675.6 4850.1 4853.9 4866.7 4884.9 5800.3 5814.5 5831.6 5849.2 5869.2 4031.6 4066.4 4071.7 4075.3 4077.9 6009.3 6192.4 6193.3 6247.3 6277.1 4095.5 4099.4 4113.7 4127.5 4138.4 4140.6 4149.4 4176.0 4184.0 4184.2 4714.7 4839.2 4845.6 4860.9 4861.8 5868.8 5880.6 5904.6 5911.7 5924.1 1440.9 1451.4 1457.1 1464.5 1466.6 933.1 959.3 980.9 985.1 986.8 4999.6 5015.1 5021.6 5023.3 5031.9 6022.9 6031.8 6033.7 6066.8 6071.7 4835.6 4970.7 4983.8 5001.9 5002.5 3182.9 3213.3 3214.5 3231.5 3231.6 5518.1 5644.5 5648.2 5652.7 5658.7 6055.5 6195.7 6232.0 6289.8 6314.2 5639.4 5640.9 5653.4 5659.4 5660.2 5981.4 6064.7 6071.7 6106.4 6113.1 5711.0 5966.7 6011.8 6018.4 6062.9 5595.9 5610.7 5628.9 5641.5 5671.8 4072.5 4129.4 4149.0 4155.5 4165.4 6100.3 6130.4 6131.6 6132.5 6133.2 5857.8 5860.2 5876.2 5897.5 5900.1 5725.3 5770.0 5864.4 5885.9 5887.1 5810.8 5819.8 5824.2 5826.7 5829.7 5800.6 5891.5 5923.3 5956.1 5956.3 5705.7 5722.3 5735.3 5739.9 5762.1 06:29:42 INFO - PID 26088 | 06:29:42 INFO - PID 26088 | [#5] yui.html Cycles:180 Average:17569.05 Median:3693.09 stddev:23037.15 (623.8%) stddev-sans-first:23066.62 06:29:42 INFO - PID 26088 | Values: 620.4 631.9 634.4 715.6 753.6 13762.0 14176.1 14225.1 15362.9 16426.8 15641.6 15658.3 15660.8 15777.9 15796.5 904.9 908.3 914.2 914.4 923.4 870.7 894.8 907.0 920.8 922.1 957.6 960.4 962.6 964.7 967.6 959.1 960.5 961.1 962.6 962.8 705.6 706.0 707.0 707.8 708.0 13233.2 13270.9 13360.6 13380.4 13423.2 15760.7 16461.6 16477.0 16589.7 16602.5 11988.7 12180.0 12410.7 12491.6 12519.1 3034.5 3045.5 3048.6 3049.9 3065.1 82490.0 82689.0 82750.0 82774.0 83651.6 12135.9 12215.0 12308.1 12383.4 12458.4 22544.9 23600.9 23672.0 23764.8 23779.0 6217.3 6303.5 6330.0 6350.7 6370.8 2959.0 3021.8 3042.0 3051.6 3066.1 3616.0 3659.3 3686.5 3688.4 3697.8 673.5 682.1 686.4 689.9 690.6 578.6 593.7 601.1 605.1 610.5 9664.4 9728.2 10171.4 10176.0 10763.5 566.0 568.6 592.9 597.2 600.3 4395.0 4563.0 4597.1 4607.2 4624.5 84118.0 85062.6 85232.0 87237.6 88090.6 70175.6 71571.6 71721.0 72182.6 74065.3 63119.7 63431.7 63477.7 65180.3 66013.3 9042.1 9044.2 9051.1 9142.5 9391.1 26750.7 26796.7 27648.9 27847.4 28165.2 47611.8 48990.3 49047.5 49324.0 50301.5 14153.9 14302.6 14408.1 14606.9 14714.4 15224.5 15394.6 15399.4 15655.2 15675.2 14618.4 15132.2 15142.7 15234.0 15256.5 14696.7 14702.3 14925.4 15073.6 15074.4 13772.9 14282.7 14343.4 14384.4 14629.2 9835.8 10239.8 10268.9 10400.3 10510.4 10478.6 10991.8 11480.8 12042.3 12165.5 06:29:42 INFO - PID 26088 | -------- Summary: end -------- 06:29:42 INFO - PID 26088 | 06:29:42 INFO - TEST-INFO | 26088: exit 0 06:29:42 INFO - TEST-OK | dromaeo_css | took 1146525ms 06:29:42 INFO - TEST-START | kraken 06:29:42 INFO - operating with platform_type : linux_ 06:29:42 INFO - Initialising browser for kraken test... 06:29:42 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:38001/getInfo.html -profile /tmp/tmpc6kAAj/profile 06:29:42 INFO - TEST-INFO | started process 26508 (/builds/slave/test/build/application/firefox/firefox http://localhost:38001/getInfo.html) 06:30:17 INFO - TEST-INFO | 26508: killed by SIGTERM 06:30:17 INFO - Browser initialized. 06:30:17 INFO - Running cycle 1/1 for kraken test... 06:30:17 INFO - TEST-INFO | started process 26730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpc6kAAj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:30:29 INFO - PID 26730 | RSS: Main: 176246784 06:30:29 INFO - PID 26730 | 06:30:32 INFO - PID 26730 | Cycle 1(1): loaded http://localhost:38001/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38001/tests/kraken/driver.html?testName=audio-beat-detection) 06:30:33 INFO - PID 26730 | RSS: Main: 181809152 06:30:33 INFO - PID 26730 | 06:30:35 INFO - PID 26730 | Cycle 1(1): loaded http://localhost:38001/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38001/tests/kraken/driver.html?testName=audio-dft) 06:30:36 INFO - PID 26730 | RSS: Main: 181448704 06:30:36 INFO - PID 26730 | 06:30:39 INFO - PID 26730 | Cycle 1(1): loaded http://localhost:38001/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38001/tests/kraken/driver.html?testName=audio-fft) 06:30:40 INFO - PID 26730 | RSS: Main: 178323456 06:30:40 INFO - PID 26730 | 06:30:42 INFO - PID 26730 | Cycle 1(1): loaded http://localhost:38001/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38001/tests/kraken/driver.html?testName=audio-oscillator) 06:30:42 INFO - PID 26730 | RSS: Main: 178569216 06:30:42 INFO - PID 26730 | 06:30:44 INFO - PID 26730 | Cycle 1(1): loaded http://localhost:38001/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38001/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:30:45 INFO - PID 26730 | RSS: Main: 178671616 06:30:45 INFO - PID 26730 | 06:30:48 INFO - PID 26730 | Cycle 1(1): loaded http://localhost:38001/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38001/tests/kraken/driver.html?testName=imaging-darkroom) 06:30:49 INFO - PID 26730 | RSS: Main: 179675136 06:30:49 INFO - PID 26730 | 06:30:52 INFO - PID 26730 | Cycle 1(1): loaded http://localhost:38001/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38001/tests/kraken/driver.html?testName=imaging-desaturate) 06:30:53 INFO - PID 26730 | RSS: Main: 179118080 06:30:53 INFO - PID 26730 | 06:30:56 INFO - PID 26730 | Cycle 1(1): loaded http://localhost:38001/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38001/tests/kraken/driver.html?testName=json-parse-financial) 06:30:57 INFO - PID 26730 | RSS: Main: 179724288 06:30:57 INFO - PID 26730 | 06:30:58 INFO - PID 26730 | Cycle 1(1): loaded http://localhost:38001/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38001/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:30:59 INFO - PID 26730 | RSS: Main: 179957760 06:30:59 INFO - PID 26730 | 06:31:01 INFO - PID 26730 | Cycle 1(1): loaded http://localhost:38001/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38001/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:31:01 INFO - PID 26730 | RSS: Main: 179687424 06:31:01 INFO - PID 26730 | 06:31:03 INFO - PID 26730 | Cycle 1(1): loaded http://localhost:38001/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38001/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:31:04 INFO - PID 26730 | RSS: Main: 179781632 06:31:04 INFO - PID 26730 | 06:31:07 INFO - PID 26730 | Cycle 1(1): loaded http://localhost:38001/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:31:08 INFO - PID 26730 | RSS: Main: 180117504 06:31:08 INFO - PID 26730 | 06:31:11 INFO - PID 26730 | Cycle 1(1): loaded http://localhost:38001/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:31:12 INFO - PID 26730 | RSS: Main: 179892224 06:31:12 INFO - PID 26730 | 06:31:13 INFO - PID 26730 | Cycle 1(1): loaded http://localhost:38001/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38001/tests/kraken/driver.html?testName=ai-astar) 06:31:14 INFO - PID 26730 | RSS: Main: 181354496 06:31:14 INFO - PID 26730 | 06:31:14 INFO - PID 26730 | __start_tp_report 06:31:14 INFO - PID 26730 | _x_x_mozilla_page_load 06:31:14 INFO - PID 26730 | _x_x_mozilla_page_load_details 06:31:14 INFO - PID 26730 | |i|pagename|runs| 06:31:14 INFO - PID 26730 | |0;ai-astar;103;113;113;111;111;113;113;111;114;114 06:31:14 INFO - PID 26730 | |1;audio-beat-detection;167;131;130;183;129;125;125;125;156;125 06:31:14 INFO - PID 26730 | |2;audio-dft;164;165;168;165;167;170;178;166;164;162 06:31:14 INFO - PID 26730 | |3;audio-fft;75;74;75;107;75;75;74;79;95;78 06:31:14 INFO - PID 26730 | |4;audio-oscillator;84;85;105;84;83;83;97;84;84;107 06:31:14 INFO - PID 26730 | |5;imaging-gaussian-blur;114;115;115;114;115;114;116;115;114;114 06:31:14 INFO - PID 26730 | |6;imaging-darkroom;150;150;150;154;151;155;154;155;154;151 06:31:14 INFO - PID 26730 | |7;imaging-desaturate;95;95;95;94;94;95;94;94;95;95 06:31:14 INFO - PID 26730 | |8;json-parse-financial;55;55;54;56;60;55;57;55;55;56 06:31:14 INFO - PID 26730 | |9;json-stringify-tinderbox;57;56;56;57;56;56;56;57;56;58 06:31:14 INFO - PID 26730 | |10;stanford-crypto-aes;96;90;95;87;85;87;89;88;112;87 06:31:14 INFO - PID 26730 | |11;stanford-crypto-ccm;138;145;138;134;139;137;137;139;138;143 06:31:14 INFO - PID 26730 | |12;stanford-crypto-pbkdf2;191;213;201;210;196;187;206;205;186;201 06:31:14 INFO - PID 26730 | |13;stanford-crypto-sha256-iterative;77;73;76;73;76;71;73;72;76;72 06:31:14 INFO - PID 26730 | __end_tp_report 06:31:14 INFO - PID 26730 | __start_cc_report 06:31:14 INFO - PID 26730 | _x_x_mozilla_cycle_collect,930 06:31:14 INFO - PID 26730 | __end_cc_report 06:31:14 INFO - PID 26730 | __startTimestamp1495719074086__endTimestamp 06:31:14 INFO - PID 26730 | 06:31:14 INFO - PID 26730 | ------- Summary: start ------- 06:31:14 INFO - PID 26730 | Number of tests: 14 06:31:14 INFO - PID 26730 | 06:31:14 INFO - PID 26730 | [#0] ai-astar Cycles:10 Average:111.60 Median:113.00 stddev:3.24 (2.9%) stddev-sans-first:1.24 06:31:14 INFO - PID 26730 | Values: 103.0 113.0 113.0 111.0 111.0 113.0 113.0 111.0 114.0 114.0 06:31:14 INFO - PID 26730 | 06:31:14 INFO - PID 26730 | [#1] audio-beat-detection Cycles:10 Average:139.60 Median:130.50 stddev:21.17 (16.2%) stddev-sans-first:20.00 06:31:14 INFO - PID 26730 | Values: 167.0 131.0 130.0 183.0 129.0 125.0 125.0 125.0 156.0 125.0 06:31:14 INFO - PID 26730 | 06:31:14 INFO - PID 26730 | [#2] audio-dft Cycles:10 Average:166.90 Median:166.50 stddev:4.51 (2.7%) stddev-sans-first:4.66 06:31:14 INFO - PID 26730 | Values: 164.0 165.0 168.0 165.0 167.0 170.0 178.0 166.0 164.0 162.0 06:31:14 INFO - PID 26730 | 06:31:14 INFO - PID 26730 | [#3] audio-fft Cycles:10 Average:80.70 Median:75.00 stddev:11.19 (14.9%) stddev-sans-first:11.67 06:31:14 INFO - PID 26730 | Values: 75.0 74.0 75.0 107.0 75.0 75.0 74.0 79.0 95.0 78.0 06:31:14 INFO - PID 26730 | 06:31:14 INFO - PID 26730 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:84.00 stddev:9.59 (11.4%) stddev-sans-first:9.96 06:31:14 INFO - PID 26730 | Values: 84.0 85.0 105.0 84.0 83.0 83.0 97.0 84.0 84.0 107.0 06:31:14 INFO - PID 26730 | 06:31:14 INFO - PID 26730 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:115.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 06:31:14 INFO - PID 26730 | Values: 114.0 115.0 115.0 114.0 115.0 114.0 116.0 115.0 114.0 114.0 06:31:14 INFO - PID 26730 | 06:31:14 INFO - PID 26730 | [#6] imaging-darkroom Cycles:10 Average:152.40 Median:154.00 stddev:2.17 (1.4%) stddev-sans-first:2.12 06:31:14 INFO - PID 26730 | Values: 150.0 150.0 150.0 154.0 151.0 155.0 154.0 155.0 154.0 151.0 06:31:14 INFO - PID 26730 | 06:31:14 INFO - PID 26730 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:31:14 INFO - PID 26730 | Values: 95.0 95.0 95.0 94.0 94.0 95.0 94.0 94.0 95.0 95.0 06:31:14 INFO - PID 26730 | 06:31:14 INFO - PID 26730 | [#8] json-parse-financial Cycles:10 Average:55.80 Median:55.50 stddev:1.69 (3.0%) stddev-sans-first:1.76 06:31:14 INFO - PID 26730 | Values: 55.0 55.0 54.0 56.0 60.0 55.0 57.0 55.0 55.0 56.0 06:31:14 INFO - PID 26730 | 06:31:14 INFO - PID 26730 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:56.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 06:31:14 INFO - PID 26730 | Values: 57.0 56.0 56.0 57.0 56.0 56.0 56.0 57.0 56.0 58.0 06:31:14 INFO - PID 26730 | 06:31:14 INFO - PID 26730 | [#10] stanford-crypto-aes Cycles:10 Average:91.60 Median:88.50 stddev:8.00 (9.0%) stddev-sans-first:8.33 06:31:14 INFO - PID 26730 | Values: 96.0 90.0 95.0 87.0 85.0 87.0 89.0 88.0 112.0 87.0 06:31:14 INFO - PID 26730 | 06:31:14 INFO - PID 26730 | [#11] stanford-crypto-ccm Cycles:10 Average:138.80 Median:138.50 stddev:3.12 (2.3%) stddev-sans-first:3.30 06:31:14 INFO - PID 26730 | Values: 138.0 145.0 138.0 134.0 139.0 137.0 137.0 139.0 138.0 143.0 06:31:14 INFO - PID 26730 | 06:31:14 INFO - PID 26730 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.60 Median:203.00 stddev:9.38 (4.6%) stddev-sans-first:9.42 06:31:14 INFO - PID 26730 | Values: 191.0 213.0 201.0 210.0 196.0 187.0 206.0 205.0 186.0 201.0 06:31:14 INFO - PID 26730 | 06:31:14 INFO - PID 26730 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.90 Median:74.50 stddev:2.13 (2.9%) stddev-sans-first:1.94 06:31:14 INFO - PID 26730 | Values: 77.0 73.0 76.0 73.0 76.0 71.0 73.0 72.0 76.0 72.0 06:31:14 INFO - PID 26730 | -------- Summary: end -------- 06:31:14 INFO - PID 26730 | 06:31:15 INFO - TEST-INFO | 26730: exit 0 06:31:15 INFO - TEST-OK | kraken | took 92365ms 06:31:15 INFO - SUITE-END | took 1238s 06:31:15 INFO - Completed test suite (00:20:38) 06:31:15 INFO - javascript benchmark 06:31:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6816.441671458547, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2720.428709970906, 2724.9046283380085, 2726.877290521926, 2756.931076723082, 2758.2828464599197, 5291.153415453528, 5336.332958380198, 5345.518903298703, 5346.0, 5349.144136938091, 5364.034473794715, 5372.167314066316, 5388.191771234317, 5475.5072043516075, 5495.780168793243, 4755.334253204537, 4799.7120172789655, 4844.927326090112, 4883.316335713003, 4884.047610715912, 4845.757712114398, 4902.093112774148, 4910.484399138093, 4916.237983112624, 4934.728589927553, 4721.409823772028, 4773.045390921795, 4798.808047678089, 4840.709557426566, 4898.24077268024, 4705.647076469244, 4752.904941901143, 4800.1119792838435, 4806.231003039532, 4808.855734327975, 4778.450478195017, 4804.543568361, 4811.374521312207, 4813.08551375241, 4865.610751139936, 5311.760970756325, 5383.380911195223, 5386.461353864622, 5393.325834270716, 5401.054815407288, 5719.084946408596, 5806.883862322772, 5826.941730582682, 5892.175095486636, 5920.703964801743, 5942.405759424023, 5947.524198064188, 5949.315828679714, 5950.434708702666, 5955.672438015908, 5489.670619762827, 5493.340799104133, 5499.7250137492965, 5502.532284755761, 5505.03661859173, 5758.424157584292, 5833.416658334218, 5851.444112809277, 6068.241469816273, 6072.574919755663, 5681.488666020078, 5747.597668163272, 5754.913676294859, 5776.971115144397, 5790.0, 5766.884662306814, 5839.211706419579, 5882.529397648178, 5886.23478947734, 5890.0, 5705.600607957404, 5794.8551286217335, 5799.884002320015, 5809.477147056785, 5836.212111364996, 5807.448292412214, 5881.676507792113, 5884.852878678067, 5888.705564721747, 5895.086261629454, 4845.466998630148, 4850.272459131088, 4857.53853383928, 4861.270809378621, 4900.681455705368, 4137.482814648169, 4150.439690641785, 4159.043420013414, 4159.875203743893, 4192.664586833046, 4743.66794324394, 4812.133815913099, 4836.516348365206, 4921.680090794087, 4922.483139270396, 5828.79599214034, 5829.59192856496, 5831.795887144014, 5836.8540786479825, 5887.028640274307, 4854.077725232195, 4862.756862156878, 4866.732329721828, 4867.513248675175, 4909.0672772173175, 4983.103041452573, 5061.468545802712, 5117.257997590328, 5120.129577971754, 5193.740312984336, 5437.483439073281, 5443.918341224806, 5457.781688732406, 5471.8084867029465, 5479.835604931858, 5672.659640421588, 5762.366139724711, 5763.0, 5829.38791426911, 5841.32824725145, 5325.281087053353, 5331.1470164773455, 5443.564514838724, 5449.509544141047, 5463.972680136574, 5785.595008349375, 5788.53691704671, 5789.8263052108505, 5809.070548712186, 5810.680412577349, 5675.035244008611, 5750.856228594319, 5751.511121554715, 5839.124131380327, 5908.881822363614, 5679.432056794288, 5701.657900525982, 5718.1136923776885, 5726.7709291629535, 5757.453041961007, 5695.117256825199, 5712.42875712442, 5713.657180569179, 5717.285339332583, 5721.084626459747, 5470.480304371078, 5565.220869078414, 5581.804636837691, 5585.860353491033, 5627.043402621646, 5618.831435056954, 5687.402822703557, 5696.0, 5707.514861236676, 5726.169705392612, 5601.383847776823, 5607.0, 5616.129499927354, 5617.606767526234, 5619.775208991595], "value": 5274.0929691493075, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.3646154384109, 688.246370224604, 713.4007433755646, 1151.7351009267863, 1192.0761409907327, 33954.66045339549, 34981.30037399257, 34996.475052874164, 35011.2997740045, 35259.47110793337, 32439.837800811023, 32859.835700821524, 32881.17797055075, 32889.50665740016, 32980.175495612624, 6158.815235542918, 6246.500279977591, 6247.281562620288, 6369.936300637004, 6410.583312084723, 6740.325967403245, 6817.590944543318, 6841.17905851296, 6845.31546845314, 6849.1438570178725, 6744.4941629377745, 6773.4242589379965, 6850.862982740342, 6852.109225800639, 6879.724811007553, 6781.186257649064, 6788.253292137861, 6804.421624161952, 6849.897251541206, 6860.3825655690725, 6627.86744265112, 6653.93346066538, 6672.199336079653, 6685.39831415175, 6688.264290927994, 31280.0, 31324.686753132406, 31361.215969600715, 31453.685463145306, 31509.684903150905, 3057.969420305813, 3060.8469576521084, 3081.6147981502313, 3086.5833112529745, 3097.0, 24302.635460468107, 24318.878405608037, 24429.26712198637, 24447.26658200257, 24476.388090297707, 2885.6825749167574, 2901.0, 2907.854607269649, 2943.4848901442374, 2949.1594895454905, 142056.0, 142567.28716356456, 143487.28256358756, 152813.0, 154799.2260038704, 39078.804605977355, 39249.21501569953, 39476.80261598674, 39492.0, 39532.604673953465, 40145.1970960585, 40459.59540404617, 40515.39226911599, 40520.0, 43009.35485967713, 12280.877191227974, 12387.256764594153, 12402.441890114966, 12434.253944763343, 12440.502379904883, 9854.260930430246, 9886.950565247127, 9892.703218903445, 9932.404055756677, 9963.202943764481, 12824.358782061046, 12924.41840117197, 12945.575986641463, 12956.0, 12971.805422918664, 5233.215017747369, 5248.0, 5303.628745987744, 5412.404635490093, 5447.264619276347, 856.3748463621591, 881.9250363719156, 888.1473785166313, 895.5119459894373, 920.1672486399818, 19866.801331986495, 20437.38687839367, 20968.0, 20979.0, 21269.68095478569, 962.8796400449944, 964.1611797736015, 976.2629214942815, 985.3250523391499, 993.7614972406715, 10389.220808439397, 11034.0, 11086.778264434666, 11124.61063862761, 11164.832527512093, 181276.0, 181395.0, 181499.0, 181881.0, 182766.0, 40852.18295634071, 40861.59138408637, 40866.79566602207, 41050.38424423636, 41195.7940210297, 1179.6940776826495, 1217.2939694976892, 1220.2617416462913, 1224.9448774804978, 1245.414655112096, 19373.612527749647, 19905.900470498134, 20546.58906821885, 20623.175072996914, 21014.474638133557, 29162.0, 36020.81989590035, 37152.81423592865, 37195.0, 37202.8139859299, 162562.1871890633, 163729.0, 163736.18131909263, 164194.0, 164405.0, 30203.244918877204, 30320.0, 30532.236694082825, 30619.693803061684, 30782.076537703906, 35333.0, 35473.645263547034, 35892.82053589715, 35994.8200258997, 36064.81967590145, 27165.370077795396, 27873.44253114967, 27963.580546291414, 28119.297017574725, 28763.42473150567, 27210.0, 27755.306117347227, 28587.571186432637, 29020.854895726232, 30648.0, 33427.164320892174, 34082.488762669076, 34312.48531271983, 34470.48294275638, 34622.82688586541, 31978.20054498656, 32742.50886236661, 33196.33607327888, 33791.83104084464, 33942.66057339494, 26020.0, 27729.861350693118, 28140.71859281381, 28289.57565636476, 28335.43329133447], "value": 14704.052988370991, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.2332885865848, 401.161572313864, 417.65543426673, 419.6978175713486, 431.92009478246524, 16863.49409517715, 17140.571485712833, 17599.472015839514, 17615.999999999985, 18032.90983545084, 17948.0, 18128.274869005258, 18143.546411339725, 18178.181981810816, 18193.18130684119, 5289.206619007141, 5502.724863756796, 5506.614536982413, 5524.58565607579, 5528.889422211573, 5187.740612969355, 5479.0, 5505.229267902497, 5516.668999860021, 5530.308711411074, 5460.290162278899, 5465.890682186354, 5482.2873026506495, 5499.065158922973, 5503.807366742165, 5392.1911713243135, 5420.105682562373, 5538.861528461781, 5573.386927437979, 5582.804601838916, 5019.824306149304, 5023.8492845214705, 5024.145895197788, 5047.293378926953, 5068.847934561933, 20977.26579569723, 21210.25764098249, 21233.46916327089, 21415.250466233763, 21625.134994600197, 1613.790207273047, 1637.0832333892938, 1651.3312108596037, 1659.037758100299, 1659.444086231114, 14454.855451445455, 14778.408863645442, 14902.925485372503, 14908.925455372653, 15249.771253431207, 2053.147943603403, 2111.535462198314, 2123.851330406872, 2131.7868213178713, 2148.0, 89001.53978443024, 89923.55038224833, 91101.0, 91649.0, 93810.0, 10908.290961087503, 11006.339619622848, 11017.889821101686, 11187.944060279646, 11445.08439324852, 15358.616034599225, 15438.614034649, 15458.84541154574, 15468.690626187414, 15486.690266194613, 7905.762827115196, 7928.8810667840025, 8046.798830029179, 8064.879026814602, 8193.262606365455, 7249.673764680602, 7324.743633972892, 7353.8161545961775, 7497.850042999218, 7554.169041405441, 6754.223264324567, 6970.222593238793, 6997.475189360818, 7016.54676617664, 7091.361777440055, 2045.8670186437835, 2077.418322869599, 2079.7296351474515, 2095.790420957892, 2241.2715867343177, 839.3620848155446, 879.6261588824851, 883.3551507399634, 890.3767362846033, 901.0628945896326, 16179.0, 16412.09733464671, 16581.91709041447, 17097.743533847002, 17206.483805485856, 856.8286342731354, 871.4814685262259, 873.7990262239721, 882.3073886998675, 884.0408157149436, 8867.201951824367, 9315.115064068903, 9400.48297343639, 9418.670346537838, 9535.284853636005, 357387.0, 361458.0, 362836.0, 366449.0, 369854.0, 72084.0, 72529.0, 73271.63364183145, 73830.0, 76282.0, 1039.859618951447, 1055.1716902231865, 1062.6918193723889, 1064.7018834726134, 1071.0467683761458, 14504.927475362556, 14542.41830326775, 14605.269736513344, 14606.853931460975, 15412.075275483507, 37442.25115497729, 37721.43417848789, 38389.80805095957, 39401.40897886477, 39471.802640986614, 46679.0, 47799.5220047809, 47844.76077619589, 48716.26925596048, 49377.0, 7530.246975302426, 7599.962000190185, 7684.193159718149, 7730.806729831575, 7765.22347765219, 11655.358955257543, 11812.881871181178, 12041.879581204075, 12051.457684404048, 12166.540015198232, 10390.376577405379, 10537.315074520131, 10568.630097946843, 10593.311434757024, 10947.522084518489, 9589.712308630753, 9663.710088697351, 9753.609855605697, 9790.85313720309, 9882.50587470638, 10744.247902646739, 10833.508293092475, 10882.347059176474, 10886.564537418732, 11062.170337224901, 7806.648700808364, 7926.881096783438, 8073.273405393308, 8095.150009248944, 8113.594320283844, 10213.489325533545, 10358.0, 10651.520681569504, 10677.519511622151, 10843.728906777395], "value": 8716.995566862126, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1241.3358853013638, 1293.3662505372358, 1296.6952766099964, 1318.8549259581448, 1319.610714839123, 10528.631497897575, 10999.395033273167, 11125.054370378528, 11130.721731956704, 11340.489677964491, 11113.499892504837, 11306.378149201812, 11325.263857849233, 11329.206955513117, 11340.546378144885, 2246.0903334149693, 2309.976900230993, 2312.4912519245822, 2313.9421514462188, 2319.165100563804, 2207.23850271656, 2237.2057919438607, 2246.7753224677563, 2251.3921241264848, 2252.234240358278, 2212.796427701229, 2226.14293497004, 2237.1722462688826, 2246.7753224677563, 2249.392663980724, 2130.573885222946, 2172.6958225848393, 2175.086463685256, 2175.793299636532, 2176.5864485747657, 2161.4812445013085, 2170.696102545645, 2179.1283486605325, 2266.8866556672265, 2288.7139107611547, 10831.2959657622, 10921.672349829518, 10962.177836662202, 10968.780624387467, 10971.670849874517, 5626.2685850839125, 5865.941340586583, 5883.911741323884, 5900.586958912878, 5905.055191169436, 3239.2225865792275, 3327.2680010397917, 3401.9659803401896, 3423.5207071010077, 3442.6729460701195, 1074.1943542343242, 1074.462768615692, 1079.2768844873954, 1110.4114819145866, 1126.6788965144895, 16125.677486450322, 16254.674906501921, 16264.837351626451, 16269.593260168473, 16281.430149944814, 4669.859904202812, 4857.684250523705, 4920.3111564381015, 4938.160512712848, 4988.301637770715, 11020.724481888017, 11049.613263535737, 11057.889421105687, 11064.557417703363, 11087.33475991443, 5672.914906276409, 5785.334686511021, 5800.158976948319, 5802.33273173582, 5804.100364443518, 5287.9735601321745, 5341.626086174008, 5342.519173274346, 5375.838724838261, 5409.540189083893, 3828.789416582059, 3919.8040097994985, 3956.090099277182, 4036.616521430459, 4055.330870406409, 1052.884182739898, 1091.8689757229183, 1106.5241945963312, 1108.4623957380663, 1114.6043154680135, 632.3771085480797, 654.5450911616476, 672.2672287206968, 680.6630717794625, 687.7620283489698, 5087.287779710843, 5208.557272631869, 5298.788048478094, 5302.92045619316, 5422.240886275925, 543.6873797566415, 559.7481133489946, 563.9887202255932, 564.5568228940263, 576.5358886096733, 3340.983295083509, 3408.2672225471642, 3426.7087297579487, 3490.9650903491147, 3828.770273783526, 12724.109312348046, 12943.482260709467, 12980.415881285177, 12984.415701293465, 13607.0, 12266.81599776004, 12844.293563853891, 12888.742225155633, 14022.088564243291, 14182.290885455892, 7727.111382191008, 7783.0660320760735, 7798.064232292161, 7848.254415830487, 7860.292573668397, 5556.805511807067, 5597.104463285855, 5610.18652295423, 5738.340090889435, 5883.61756485827, 12433.440495177558, 12732.554360597334, 12752.6811829705, 12908.290044047668, 13066.869331306565, 12791.744165116459, 12950.093493455368, 13100.672483187996, 13114.672133196746, 13371.531996380469, 7546.094468663796, 7832.216778322122, 8233.958830205811, 8686.695965641173, 8719.694810681849, 10547.683569492927, 10551.103156231806, 10558.472076396303, 10574.471276436301, 10616.0, 8316.5425901576, 8353.83292334162, 8432.873506897524, 8481.575921203792, 8624.059586593217, 8373.62318695648, 8381.664733410595, 8536.0, 8666.35002374837, 8789.912100879164, 6795.762148324785, 6864.313568643096, 6878.037074809431, 6879.346462086094, 6966.12923384577, 4972.378452693413, 5024.0956627807345, 5107.514786095315, 5145.691258524501, 5231.084560202025, 5252.369715634149, 5298.304542546348, 5301.469853014668, 5310.3893052297935, 5414.538074719882], "value": 4762.193160622674, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [372.9981350093249, 374.9681277091447, 376.8266597365212, 377.2360969037698, 386.62497377543775, 5471.79620483493, 5557.888422315538, 5586.83239502815, 5590.301212348451, 5635.718214089299, 5388.595855310858, 5457.890842183154, 5473.31583552056, 5534.723263836812, 5548.223248745179, 4050.6961977851633, 4139.958600414003, 4167.166566686659, 4183.330667093273, 4187.20443115807, 4185.560516145806, 4188.643965262956, 4196.916061678765, 4198.244316023115, 4206.200821843855, 4144.647704945083, 4146.958530414702, 4159.500859896817, 4168.895777605554, 4182.853600123996, 4108.8356465741335, 4149.962509372657, 4162.979185104085, 4167.374893765929, 4170.4369910062205, 3645.981770091159, 3652.5982141964364, 3653.0867283179205, 3654.086478380405, 3657.9268414631824, 5392.487713667196, 5404.919016196776, 5407.37669292753, 5408.134698448269, 5411.702356370398, 4675.555822196886, 4850.102730994778, 4853.927191092136, 4866.732329721864, 4884.877878053042, 5800.303963524362, 5814.534837213013, 5831.620944638585, 5849.151872978437, 5869.207656966298, 4031.637152656275, 4066.3900414937702, 4071.7149799514045, 4075.3071977763852, 4077.857274995361, 6009.308929473123, 6192.442680158807, 6193.274959018017, 6247.312795592436, 6277.121203031534, 4095.5494895561465, 4099.446574712376, 4113.691473139526, 4127.504699436087, 4138.358554424069, 4140.60664236897, 4149.356849688304, 4176.0, 4183.97908010458, 4184.184084103571, 4714.693544919569, 4839.153148199051, 4845.6123510119105, 4860.92708609364, 4861.781219845116, 5868.767558812697, 5880.558958078162, 5904.586678932434, 5911.674857882772, 5924.140999555127, 1440.942362305496, 1451.4484495891493, 1457.1475686723174, 1464.5313499680212, 1466.5893549806071, 933.1135421349745, 959.3476436023432, 980.887197972228, 985.0789511806483, 986.8322385194534, 4999.625028122832, 5015.122353588107, 5021.59827213822, 5023.296738456619, 5031.924521132186, 6022.9044249910485, 6031.828541724975, 6033.66021071355, 6066.817995460143, 6071.696415179312, 4835.637327200474, 4970.701757894538, 4983.750812459362, 5001.9499805002215, 5002.499750024968, 3182.870081121169, 3213.293075523381, 3214.4856822908223, 3231.4668079767043, 3231.579894613685, 5518.117101263779, 5644.520215781705, 5648.152777083388, 5652.74562644682, 5658.660480371191, 6055.515558755289, 6195.659238741822, 6231.9688401557705, 6289.842753931189, 6314.179156709598, 5639.351474580394, 5640.8871822563315, 5653.381835625203, 5659.434056594308, 5660.179274005329, 5981.3719559445635, 6064.666443345658, 6071.662409972104, 6106.389361063858, 6113.14415981754, 5710.971445142748, 5966.701664916824, 6011.7595296187665, 6018.3981601841215, 6062.909056364247, 5595.901536923654, 5610.691411972218, 5628.915566266427, 5641.464060914206, 5671.829845104653, 4072.511298644182, 4129.442525259052, 4148.979255103705, 4155.542890282006, 4165.375193720966, 6100.26796784371, 6130.41761032719, 6131.570790044654, 6132.509399248139, 6133.202683651275, 5857.7949771757785, 5860.179574859609, 5876.1773351731645, 5897.528197744256, 5900.11498275245, 5725.341585717696, 5769.971150144391, 5864.44287792659, 5885.911711324248, 5887.146363777314, 5810.82567522975, 5819.82540523785, 5824.184614154106, 5826.679532625746, 5829.717462158318, 5800.564957628279, 5891.469767720926, 5923.259592550931, 5956.076808094752, 5956.285245770535, 5705.743241554057, 5722.341930677859, 5735.340435849931, 5739.856503587277, 5762.1068734346245], "value": 4366.635008447001, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [620.3765215957962, 631.8894193516134, 634.4226753654174, 715.5563550598627, 753.6307209467362, 13761.967852411059, 14176.078554893938, 14225.075370100936, 15362.923185384057, 16426.75359869603, 15641.608959776011, 15658.295376708047, 15660.84339156608, 15777.921110394433, 15796.526104216864, 904.8778414913985, 908.2643059122099, 914.2457472585111, 914.3782228084899, 923.353652443289, 870.6996086350199, 894.838928992781, 907.0385391485047, 920.8066306075732, 922.1101636920371, 957.5978089202517, 960.433344326847, 962.6438217859402, 964.662368171138, 967.6371360739722, 959.1415682963708, 960.5149399553251, 961.1109723505764, 962.5957098018849, 962.7785609309898, 705.5696025424487, 705.9576425414491, 706.9646517674147, 707.7735124760079, 707.9539829911091, 13233.206007639476, 13270.867291327157, 13360.599182024554, 13380.397882095329, 13423.194608323434, 15760.68478630421, 16461.58846028847, 16477.0, 16589.6682066358, 16602.50192494227, 11988.681245063037, 12180.0, 12410.689732756662, 12491.625251242478, 12519.12366134371, 3034.4841376965746, 3045.4822680144207, 3048.6341639003463, 3049.9390012199633, 3065.1417603071177, 82490.0, 82688.9999999994, 82750.0, 82774.0, 83651.5817420909, 12135.878641213474, 12215.0, 12308.076894232969, 12383.442745076492, 12458.439370228361, 22544.887275563844, 23600.881995589913, 23672.0, 23764.7623523766, 23779.0, 6217.347178546278, 6303.527235457359, 6329.9872020476505, 6350.714217860207, 6370.8088757337355, 2958.9704102958694, 3021.8035827671133, 3041.9543706843974, 3051.61854768154, 3066.1414803854955, 3616.0, 3659.341318562684, 3686.4838922550866, 3688.3914154164263, 3697.7966211858607, 673.5016088094775, 682.1336902134261, 686.4371215603257, 689.9103116594811, 690.5925503952692, 578.6036564953021, 593.6527131628046, 601.0923505506717, 605.1104875832519, 610.5359926455836, 9664.420134791935, 9728.221742260603, 10171.389716617026, 10176.0, 10763.515641796137, 566.0405612486795, 568.6019786149711, 592.8962431574457, 597.2295738497377, 600.2886579403421, 4394.956050439455, 4563.0, 4597.126545956257, 4607.216773148572, 4624.5144259852905, 84118.0, 85062.57468712617, 85232.0, 87237.5638121818, 88090.55954720185, 70175.64912175406, 71571.64214179, 71721.0, 72182.63908680528, 74065.25934740584, 63119.684401577695, 63431.6828415855, 63477.68261158665, 65180.348196518375, 66013.33986660071, 9042.095790421168, 9044.186023257938, 9051.094890510896, 9142.542872856464, 9391.107844754737, 26750.732492674822, 26796.732032680204, 27648.861755691094, 27847.44305113846, 28165.15504534867, 47611.761941190074, 48990.265146022124, 49047.50952490572, 49324.0, 50301.496985031146, 14153.858461415666, 14302.642433939234, 14408.13551186932, 14606.926965365104, 14714.411423542939, 15224.46714364992, 15394.615134621725, 15399.384024638888, 15655.21723913777, 15675.216239188223, 14618.41526338977, 15132.167730774472, 15142.697146057237, 15234.0, 15256.466023689118, 14696.706065878836, 14702.338394772047, 14925.402983880524, 15073.623159420664, 15074.397024118913, 13772.931135344259, 14282.714345713235, 14343.426262949783, 14384.424623014962, 14629.195394253418, 9835.803283934425, 10239.795204095728, 10268.948655256676, 10400.323978941344, 10510.421926793793, 10478.63324783629, 10991.780164396827, 11480.770384592428, 12042.277463352228, 12165.513379464723], "value": 7135.260541812226, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1566.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 113.0, 111.0, 111.0, 113.0, 113.0, 111.0, 114.0, 114.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 131.0, 130.0, 183.0, 129.0, 125.0, 125.0, 125.0, 156.0, 125.0], "value": 139.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 168.0, 165.0, 167.0, 170.0, 178.0, 166.0, 164.0, 162.0], "value": 166.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 107.0, 75.0, 75.0, 74.0, 79.0, 95.0, 78.0], "value": 80.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 105.0, 84.0, 83.0, 83.0, 97.0, 84.0, 84.0, 107.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 114.0, 115.0, 114.0, 116.0, 115.0, 114.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 154.0, 151.0, 155.0, 154.0, 155.0, 154.0, 151.0], "value": 152.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 54.0, 56.0, 60.0, 55.0, 57.0, 55.0, 55.0, 56.0], "value": 55.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 56.0, 57.0, 56.0, 56.0, 56.0, 57.0, 56.0, 58.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 90.0, 95.0, 87.0, 85.0, 87.0, 89.0, 88.0, 112.0, 87.0], "value": 91.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 145.0, 138.0, 134.0, 139.0, 137.0, 137.0, 139.0, 138.0, 143.0], "value": 138.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 213.0, 201.0, 210.0, 196.0, 187.0, 206.0, 205.0, 186.0, 201.0], "value": 199.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 73.0, 76.0, 73.0, 76.0, 71.0, 73.0, 72.0, 76.0, 72.0], "value": 73.9, "unit": "score"}]}]} 06:31:15 INFO - Return code: 0 06:31:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:31:15 INFO - # TBPL SUCCESS # 06:31:15 INFO - Running post-action listener: _resource_record_post_action 06:31:15 INFO - [mozharness: 2017-05-25 13:31:15.371866Z] Finished run-tests step (success) 06:31:15 INFO - Running post-run listener: _resource_record_post_run 06:31:15 INFO - Total resource usage - Wall time: 1255s; CPU: 13.0%; Read bytes: 4096; Write bytes: 409489408; Read time: 12; Write time: 292360 06:31:15 INFO - TinderboxPrint: CPU usage
12.9% 06:31:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 06:31:15 INFO - TinderboxPrint: I/O write bytes / time
409,489,408 / 292,360 06:31:15 INFO - TinderboxPrint: CPU idle
8,731.0 (87.1%) 06:31:15 INFO - TinderboxPrint: CPU user
1,232.4 (12.3%) 06:31:15 INFO - TinderboxPrint: Swap in / out
0 / 0 06:31:15 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 99237888; Read time: 0; Write time: 102020 06:31:15 INFO - run-tests - Wall time: 1239s; CPU: 13.0%; Read bytes: 0; Write bytes: 310251520; Read time: 0; Write time: 190340 06:31:16 INFO - Running post-run listener: _upload_blobber_files 06:31:16 INFO - Blob upload gear active. 06:31:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:31:16 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 06:31:16 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'] 06:31:16 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 06:31:16 INFO - (blobuploader) - INFO - Open directory for files ... 06:31:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:31:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:31:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:31:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:31:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:31:17 INFO - (blobuploader) - INFO - Done attempting. 06:31:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:31:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:31:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:31:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:31:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:31:23 INFO - (blobuploader) - INFO - Done attempting. 06:31:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:31:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:31:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:31:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:31:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:31:24 INFO - (blobuploader) - INFO - Done attempting. 06:31:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:31:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:31:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:31:25 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:31:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:31:25 INFO - (blobuploader) - INFO - Done attempting. 06:31:25 INFO - (blobuploader) - INFO - Iteration through files over. 06:31:25 INFO - Return code: 0 06:31:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:31:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:31:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1a0916733a0e3f044c62f2b30d14baa9910d631fbc214fe2e8ed55cd5566ec57221c162e55920a2384a858f9f5d57f2c8f1e89ce2eb6f2c71baf39f87abb118", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/925f4451902a688676d455e4a0348fde84ad5874c19d4f01db4035d933bc1df7a24b6f50aa5cc4813dc6386c3229633a1538cf3d837befa7615f89c944cfc5de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa5962b8844edaaaf3c3731ea5436fccaf983f01f01055a2f7555334af24b752662232863e109675eb19bb9a45890c3e92dd0dddff18332db72fe9bf8e7b9906", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2abc1f3ed205aeaa481efb759ef15c47fd46c4e9d4f8eb1f64189b12db1d016632ca9775457ee385ce07b17984481fc5f040a084dc3b217fedf2e7675e241563"} 06:31:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:31:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:31:25 INFO - Contents: 06:31:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1a0916733a0e3f044c62f2b30d14baa9910d631fbc214fe2e8ed55cd5566ec57221c162e55920a2384a858f9f5d57f2c8f1e89ce2eb6f2c71baf39f87abb118", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/925f4451902a688676d455e4a0348fde84ad5874c19d4f01db4035d933bc1df7a24b6f50aa5cc4813dc6386c3229633a1538cf3d837befa7615f89c944cfc5de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa5962b8844edaaaf3c3731ea5436fccaf983f01f01055a2f7555334af24b752662232863e109675eb19bb9a45890c3e92dd0dddff18332db72fe9bf8e7b9906", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2abc1f3ed205aeaa481efb759ef15c47fd46c4e9d4f8eb1f64189b12db1d016632ca9775457ee385ce07b17984481fc5f040a084dc3b217fedf2e7675e241563"} 06:31:25 INFO - Running post-run listener: copy_logs_to_upload_dir 06:31:25 INFO - Copying logs to upload dir... 06:31:25 INFO - mkdir: /builds/slave/test/build/upload/logs 06:31:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1316.887861 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2017-05-25 06:31:25.141373) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 06:31:25.145113) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920 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/f1a0916733a0e3f044c62f2b30d14baa9910d631fbc214fe2e8ed55cd5566ec57221c162e55920a2384a858f9f5d57f2c8f1e89ce2eb6f2c71baf39f87abb118", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/925f4451902a688676d455e4a0348fde84ad5874c19d4f01db4035d933bc1df7a24b6f50aa5cc4813dc6386c3229633a1538cf3d837befa7615f89c944cfc5de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa5962b8844edaaaf3c3731ea5436fccaf983f01f01055a2f7555334af24b752662232863e109675eb19bb9a45890c3e92dd0dddff18332db72fe9bf8e7b9906", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2abc1f3ed205aeaa481efb759ef15c47fd46c4e9d4f8eb1f64189b12db1d016632ca9775457ee385ce07b17984481fc5f040a084dc3b217fedf2e7675e241563"} build_url:https://queue.taskcluster.net/v1/task/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011479 build_url: 'https://queue.taskcluster.net/v1/task/awcs871OSjuZ3n2G3PaW4A/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f1a0916733a0e3f044c62f2b30d14baa9910d631fbc214fe2e8ed55cd5566ec57221c162e55920a2384a858f9f5d57f2c8f1e89ce2eb6f2c71baf39f87abb118", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/925f4451902a688676d455e4a0348fde84ad5874c19d4f01db4035d933bc1df7a24b6f50aa5cc4813dc6386c3229633a1538cf3d837befa7615f89c944cfc5de", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa5962b8844edaaaf3c3731ea5436fccaf983f01f01055a2f7555334af24b752662232863e109675eb19bb9a45890c3e92dd0dddff18332db72fe9bf8e7b9906", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2abc1f3ed205aeaa481efb759ef15c47fd46c4e9d4f8eb1f64189b12db1d016632ca9775457ee385ce07b17984481fc5f040a084dc3b217fedf2e7675e241563"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-25 06:31:25.170031) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:31:25.170389) ========= 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=88e9d754c8c9af9f7805d7f3000001bd-1495710492.900047-630891920 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-25 06:31:25.253805) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 06:31:25.254168) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-25 06:31:25.254539) ========= ========= Total master_lag: 0.17 =========