builder: mozilla-beta_ubuntu64_hw_devedition_test-dromaeojs-e10s slave: talos-linux64-ix-063 starttime: 1500395429.75 results: success (0) revision: 760d9091f2d4fd1131b7455365861eeda2e6ba8f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-18 09:30:29.747819) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-18 09:30:29.748405) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-18 09:30:29.748712) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-18 09:30:29.779289) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 09:30:29.779834) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-18 09:30:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2017-07-18 09:30:30 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.199976 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 09:30:30.004656) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 09:30:30.005023) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015110 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 09:30:30.063762) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 09:30:30.064161) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 760d9091f2d4fd1131b7455365861eeda2e6ba8f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 760d9091f2d4fd1131b7455365861eeda2e6ba8f --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=769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-18 09:30:30,218 truncating revision to first 12 chars 2017-07-18 09:30:30,218 Setting DEBUG logging. 2017-07-18 09:30:30,218 attempt 1/10 2017-07-18 09:30:30,218 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/760d9091f2d4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-18 09:30:30,659 unpacking tar archive at: mozilla-beta-760d9091f2d4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.749816 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 09:30:30.828885) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-18 09:30:30.829221) ========= script_repo_revision: 760d9091f2d4fd1131b7455365861eeda2e6ba8f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-18 09:30:30.829616) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-18 09:30:30.829891) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-18 09:30:30.842783) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 39 secs) (at 2017-07-18 09:30:30.843166) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:30:31 INFO - MultiFileLogger online at 20170718 09:30:31 in /builds/slave/test 09:30:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 09:30:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:30:31 INFO - {'append_to_log': False, 09:30:31 INFO - 'base_work_dir': '/builds/slave/test', 09:30:31 INFO - 'blob_upload_branch': 'Mozilla-Beta', 09:30:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:30:31 INFO - 'branch': 'Mozilla-Beta', 09:30:31 INFO - 'buildbot_json_path': 'buildprops.json', 09:30:31 INFO - 'config_files': ('talos/linux_config.py',), 09:30:31 INFO - 'default_actions': ('clobber', 09:30:31 INFO - 'read-buildbot-config', 09:30:31 INFO - 'download-and-extract', 09:30:31 INFO - 'populate-webroot', 09:30:31 INFO - 'create-virtualenv', 09:30:31 INFO - 'install', 09:30:31 INFO - 'setup-mitmproxy', 09:30:31 INFO - 'run-tests'), 09:30:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:30:31 INFO - 'download_minidump_stackwalk': True, 09:30:31 INFO - 'download_symbols': 'ondemand', 09:30:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:30:31 INFO - 'tooltool.py': '/tools/tooltool.py', 09:30:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:30:31 INFO - '/tools/misc-python/virtualenv.py')}, 09:30:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:30:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:30:31 INFO - 'gecko_profile': False, 09:30:31 INFO - 'gecko_profile_interval': 0, 09:30:31 INFO - 'installer_path': 'installer.exe', 09:30:31 INFO - 'log_level': 'info', 09:30:31 INFO - 'log_name': 'talos', 09:30:31 INFO - 'log_to_console': True, 09:30:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:30:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:30:31 INFO - 'opt_config_files': (), 09:30:31 INFO - 'pip_index': False, 09:30:31 INFO - 'suite': 'dromaeojs-e10s', 09:30:31 INFO - 'system_bits': '32', 09:30:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:30:31 INFO - 'title': 'talos-linux64-ix-063', 09:30:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:30:31 INFO - 'use_talos_json': True, 09:30:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:30:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:30:31 INFO - 'work_dir': 'build'} 09:30:31 INFO - [mozharness: 2017-07-18 16:30:31.105544Z] Running clobber step. 09:30:31 INFO - Running pre-action listener: _resource_record_pre_action 09:30:31 INFO - Running main action method: clobber 09:30:31 INFO - rmtree: /builds/slave/test/build 09:30:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:30:32 INFO - Running post-action listener: _resource_record_post_action 09:30:32 INFO - [mozharness: 2017-07-18 16:30:32.663754Z] Finished clobber step (success) 09:30:32 INFO - [mozharness: 2017-07-18 16:30:32.663855Z] Running read-buildbot-config step. 09:30:32 INFO - Running pre-action listener: _resource_record_pre_action 09:30:32 INFO - Running main action method: read_buildbot_config 09:30:32 INFO - Using buildbot properties: 09:30:32 INFO - { 09:30:32 INFO - "project": "", 09:30:32 INFO - "product": "firefox", 09:30:32 INFO - "who": "ffxbld@noreply.mozilla.org", 09:30:32 INFO - "installer_path": "public/build/target.tar.bz2", 09:30:32 INFO - "builddir": "mozilla-beta_ubuntu64_hw_devedition_test-dromaeojs-e10s", 09:30:32 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-beta/", 09:30:32 INFO - "buildername": "Ubuntu HW 12.04 x64 devedition mozilla-beta talos dromaeojs-e10s", 09:30:32 INFO - "stage_platform": "linux64-devedition", 09:30:32 INFO - "basedir": "/builds/slave/test", 09:30:32 INFO - "buildnumber": 1, 09:30:32 INFO - "platform": "ubuntu64_hw_devedition", 09:30:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:30:32 INFO - "slavebuilddir": "test", 09:30:32 INFO - "taskId": "aBz8OXl4RG67EVoNCDeBRg", 09:30:32 INFO - "branch": "mozilla-beta", 09:30:32 INFO - "script_repo_revision": "production", 09:30:32 INFO - "revision": "760d9091f2d4fd1131b7455365861eeda2e6ba8f", 09:30:32 INFO - "slavename": "talos-linux64-ix-063", 09:30:32 INFO - "repo_path": "releases/mozilla-beta" 09:30:32 INFO - } 09:30:32 INFO - Finding installer, test and symbols from parent task. 09:30:32 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aBz8OXl4RG67EVoNCDeBRg'}, attempt #1 09:30:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/aBz8OXl4RG67EVoNCDeBRg'}, attempt #1 09:30:33 INFO - Task dependencies: Sbgt9NhDT9q9fznE5Nuz-Q 09:30:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q'}, attempt #1 09:30:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/target.tar.bz2 09:30:34 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/test_packages.json 09:30:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/target.crashreporter-symbols.zip 09:30:34 INFO - Running post-action listener: _resource_record_post_action 09:30:34 INFO - [mozharness: 2017-07-18 16:30:34.050286Z] Finished read-buildbot-config step (success) 09:30:34 INFO - [mozharness: 2017-07-18 16:30:34.050506Z] Running download-and-extract step. 09:30:34 INFO - Running pre-action listener: _resource_record_pre_action 09:30:34 INFO - Running main action method: download_and_extract 09:30:34 INFO - mkdir: /builds/slave/test/build/tests 09:30:34 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')]} 09:30:34 INFO - trying https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/target.test_packages.json 09:30:34 INFO - Downloading https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:30:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:30:34 INFO - Downloaded 989 bytes. 09:30:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:30:34 INFO - Using the following test package requirements: 09:30:34 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 09:30:34 INFO - u'common': [u'target.common.tests.zip'], 09:30:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:30:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:30:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:30:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:30:34 INFO - u'mozbase': [u'target.common.tests.zip'], 09:30:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:30:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:30:34 INFO - u'web-platform': [u'target.common.tests.zip', 09:30:34 INFO - u'target.web-platform.tests.tar.gz'], 09:30:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:30:34 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:30:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/target.common.tests.zip 09:30:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:30:34 INFO - Fetch https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/target.common.tests.zip into memory 09:30:35 INFO - Content-Length response header: 68430938 09:30:35 INFO - Bytes received: 68430938 09:30:46 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:30:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/target.common.tests.zip 09:30:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:30:46 INFO - Fetch https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/target.common.tests.zip into memory 09:30:48 INFO - Content-Length response header: 68430938 09:30:48 INFO - Bytes received: 68430938 09:31:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/target.talos.tests.zip 09:31:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:31:00 INFO - Fetch https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/target.talos.tests.zip into memory 09:31:00 INFO - Content-Length response header: 14454898 09:31:00 INFO - Bytes received: 14454898 09:31:01 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')]} 09:31:01 INFO - trying https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/target.tar.bz2 09:31:01 INFO - Downloading https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:31:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:31:02 INFO - Downloaded 58336893 bytes. 09:31:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/target.tar.bz2 09:31:02 INFO - mkdir: /builds/slave/test/properties 09:31:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:31:02 INFO - Writing to file /builds/slave/test/properties/build_url 09:31:02 INFO - Contents: 09:31:02 INFO - build_url:https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/target.tar.bz2 09:31:02 INFO - Running post-action listener: _resource_record_post_action 09:31:02 INFO - Running post-action listener: set_extra_try_arguments 09:31:02 INFO - [mozharness: 2017-07-18 16:31:02.133152Z] Finished download-and-extract step (success) 09:31:02 INFO - [mozharness: 2017-07-18 16:31:02.133248Z] Running populate-webroot step. 09:31:02 INFO - Running pre-action listener: _resource_record_pre_action 09:31:02 INFO - Running main action method: populate_webroot 09:31:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:31:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:31:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:31:02 INFO - '--tppagecycles', 09:31:02 INFO - '7'], 09:31:02 INFO - 'tests': ['tsvgm']}}, 09:31:02 INFO - 'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:31:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:31:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:31:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:31:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:31:02 INFO - 'talos_options': ['--disable-e10s'], 09:31:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:31:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:31:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:31:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:31:02 INFO - 'talos_options': ['--disable-e10s'], 09:31:02 INFO - 'tests': ['damp', 'tps']}, 09:31:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:31:02 INFO - 'tests': ['damp', 'tps']}, 09:31:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:31:02 INFO - 'tests': ['dromaeo_dom']}, 09:31:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:31:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:31:02 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:31:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:31:02 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 09:31:02 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 09:31:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:31:02 INFO - 'tests': ['a11yr', 09:31:02 INFO - 'ts_paint', 09:31:02 INFO - 'tpaint', 09:31:02 INFO - 'sessionrestore', 09:31:02 INFO - 'sessionrestore_no_auto_restore', 09:31:02 INFO - 'tabpaint']}, 09:31:02 INFO - 'other-e10s': {'tests': ['a11yr', 09:31:02 INFO - 'ts_paint', 09:31:02 INFO - 'tpaint', 09:31:02 INFO - 'sessionrestore', 09:31:02 INFO - 'sessionrestore_no_auto_restore', 09:31:02 INFO - 'tabpaint']}, 09:31:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:31:02 INFO - 'ts_paint', 09:31:02 INFO - 'tpaint', 09:31:02 INFO - 'sessionrestore', 09:31:02 INFO - 'sessionrestore_no_auto_restore', 09:31:02 INFO - 'tabpaint']}, 09:31:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:31:02 INFO - 'ts_paint', 09:31:02 INFO - 'tpaint', 09:31:02 INFO - 'sessionrestore', 09:31:02 INFO - 'sessionrestore_no_auto_restore', 09:31:02 INFO - 'tabpaint']}, 09:31:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:31:02 INFO - 'tests': ['a11yr', 09:31:02 INFO - 'ts_paint', 09:31:02 INFO - 'tpaint', 09:31:02 INFO - 'sessionrestore', 09:31:02 INFO - 'sessionrestore_no_auto_restore', 09:31:02 INFO - 'tabpaint']}, 09:31:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:31:02 INFO - 'tests': ['a11yr', 09:31:02 INFO - 'ts_paint', 09:31:02 INFO - 'tpaint', 09:31:02 INFO - 'sessionrestore', 09:31:02 INFO - 'sessionrestore_no_auto_restore', 09:31:02 INFO - 'tabpaint']}, 09:31:02 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:31:02 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:31:02 INFO - 'bloom_basic_ref']}, 09:31:02 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 09:31:02 INFO - 'talos_options': ['--mitmproxy', 09:31:02 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 09:31:02 INFO - '--firstNonBlankPaint'], 09:31:02 INFO - 'tests': ['quantum_pageload_google', 09:31:02 INFO - 'quantum_pageload_youtube', 09:31:02 INFO - 'quantum_pageload_amazon', 09:31:02 INFO - 'quantum_pageload_facebook']}, 09:31:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:31:02 INFO - 'tests': ['tsvgx', 09:31:02 INFO - 'tsvgr_opacity', 09:31:02 INFO - 'tart', 09:31:02 INFO - 'tscrollx', 09:31:02 INFO - 'cart', 09:31:02 INFO - 'tsvg_static']}, 09:31:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:31:02 INFO - 'tsvgr_opacity', 09:31:02 INFO - 'tart', 09:31:02 INFO - 'tscrollx', 09:31:02 INFO - 'cart', 09:31:02 INFO - 'tsvg_static']}, 09:31:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:31:02 INFO - 'talos_options': ['--disable-e10s'], 09:31:02 INFO - 'tests': ['tp5o']}, 09:31:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:31:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:31:02 INFO - 'talos_options': ['--disable-e10s', 09:31:02 INFO - '--xperf_path', 09:31:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:31:02 INFO - 'tests': ['tp5n']}, 09:31:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:31:02 INFO - 'talos_options': ['--xperf_path', 09:31:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:31:02 INFO - 'tests': ['tp5n']}}, 09:31:02 INFO - 'talos.zip': {'path': '', 09:31:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:31:02 INFO - Running post-action listener: _resource_record_post_action 09:31:02 INFO - [mozharness: 2017-07-18 16:31:02.148048Z] Finished populate-webroot step (success) 09:31:02 INFO - [mozharness: 2017-07-18 16:31:02.148138Z] Running create-virtualenv step. 09:31:02 INFO - Running pre-action listener: _resource_record_pre_action 09:31:02 INFO - Running main action method: create_virtualenv 09:31:02 INFO - Creating virtualenv /builds/slave/test/build/venv 09:31:02 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 09:31:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:31:02 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 09:31:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:31:02 INFO - Using real prefix '/usr' 09:31:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:31:02 INFO - Installing distribute.............................................................................................................................................................................................done. 09:31:04 INFO - Installing pip.................done. 09:31:04 INFO - Return code: 0 09:31:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:31:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:31:04 INFO - Reading from file tmpfile_stdout 09:31:04 INFO - Output received: 09:31:04 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) 09:31:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:31:04 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')]} 09:31:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:04 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')]} 09:31:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:04 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 0x17bc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b38140>, '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 0x1b38a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b38ed0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014', '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 09:31:04 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 09:31:04 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 09:31:04 INFO - Using env: {'DISPLAY': ':0', 09:31:04 INFO - 'HOME': '/home/cltbld', 09:31:04 INFO - 'LANG': 'en_US.UTF-8', 09:31:04 INFO - 'LANGUAGE': 'en_US:en', 09:31:04 INFO - 'LOGNAME': 'cltbld', 09:31:04 INFO - 'MAIL': '/var/mail/cltbld', 09:31:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:04 INFO - 'MOZ_NO_REMOTE': '1', 09:31:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:04 INFO - 'NO_EM_RESTART': '1', 09:31:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:04 INFO - 'PWD': '/builds/slave/test', 09:31:04 INFO - 'SHELL': '/bin/bash', 09:31:04 INFO - 'SHLVL': '1', 09:31:04 INFO - 'TERM': 'linux', 09:31:04 INFO - 'TMOUT': '86400', 09:31:04 INFO - 'USER': 'cltbld', 09:31:04 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014', 09:31:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:04 INFO - '_': '/tools/buildbot/bin/python'} 09:31:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:05 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 09:31:05 INFO - Cleaning up... 09:31:05 INFO - Return code: 0 09:31:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:31: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')]} 09:31:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31: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')]} 09:31:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31: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', '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 0x17bc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b38140>, '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 0x1b38a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b38ed0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014', '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 09:31: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', 'psutil>=3.1.1'] in /builds/slave/test/build 09:31: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 psutil>=3.1.1 09:31:05 INFO - Using env: {'DISPLAY': ':0', 09:31:05 INFO - 'HOME': '/home/cltbld', 09:31:05 INFO - 'LANG': 'en_US.UTF-8', 09:31:05 INFO - 'LANGUAGE': 'en_US:en', 09:31:05 INFO - 'LOGNAME': 'cltbld', 09:31:05 INFO - 'MAIL': '/var/mail/cltbld', 09:31:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:05 INFO - 'MOZ_NO_REMOTE': '1', 09:31:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:05 INFO - 'NO_EM_RESTART': '1', 09:31:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:05 INFO - 'PWD': '/builds/slave/test', 09:31:05 INFO - 'SHELL': '/bin/bash', 09:31:05 INFO - 'SHLVL': '1', 09:31:05 INFO - 'TERM': 'linux', 09:31:05 INFO - 'TMOUT': '86400', 09:31:05 INFO - 'USER': 'cltbld', 09:31:05 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014', 09:31:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:05 INFO - '_': '/tools/buildbot/bin/python'} 09:31:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:05 INFO - Downloading/unpacking psutil>=3.1.1 09:31: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 09:31: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 09:31: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 09:31: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 09:31:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:31:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:31:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:31:06 INFO - Installing collected packages: psutil 09:31:06 INFO - Running setup.py install for psutil 09:31:06 INFO - building 'psutil._psutil_linux' extension 09:31:06 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 09:31:06 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 09:31:06 INFO - building 'psutil._psutil_posix' extension 09:31:06 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 09:31:06 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 09:31:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:31:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:31:07 INFO - Successfully installed psutil 09:31:07 INFO - Cleaning up... 09:31:07 INFO - Return code: 0 09:31:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:31: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')]} 09:31:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31: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')]} 09:31:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17bc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b38140>, '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 0x1b38a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b38ed0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014', '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 09:31: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:31: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 mozsystemmonitor==0.3 09:31:07 INFO - Using env: {'DISPLAY': ':0', 09:31:07 INFO - 'HOME': '/home/cltbld', 09:31:07 INFO - 'LANG': 'en_US.UTF-8', 09:31:07 INFO - 'LANGUAGE': 'en_US:en', 09:31:07 INFO - 'LOGNAME': 'cltbld', 09:31:07 INFO - 'MAIL': '/var/mail/cltbld', 09:31:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:07 INFO - 'MOZ_NO_REMOTE': '1', 09:31:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:07 INFO - 'NO_EM_RESTART': '1', 09:31:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:07 INFO - 'PWD': '/builds/slave/test', 09:31:07 INFO - 'SHELL': '/bin/bash', 09:31:07 INFO - 'SHLVL': '1', 09:31:07 INFO - 'TERM': 'linux', 09:31:07 INFO - 'TMOUT': '86400', 09:31:07 INFO - 'USER': 'cltbld', 09:31:07 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014', 09:31:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:07 INFO - '_': '/tools/buildbot/bin/python'} 09:31:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:31: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 09:31: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 09:31: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 09:31: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 09:31:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:31:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:31:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:31:08 INFO - Installing collected packages: mozsystemmonitor 09:31:08 INFO - Running setup.py install for mozsystemmonitor 09:31:08 INFO - Successfully installed mozsystemmonitor 09:31:08 INFO - Cleaning up... 09:31:08 INFO - Return code: 0 09:31:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:31: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')]} 09:31:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31: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')]} 09:31:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31: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', '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 0x17bc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b38140>, '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 0x1b38a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b38ed0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014', '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 09:31: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 09:31: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 jsonschema==2.5.1 09:31:08 INFO - Using env: {'DISPLAY': ':0', 09:31:08 INFO - 'HOME': '/home/cltbld', 09:31:08 INFO - 'LANG': 'en_US.UTF-8', 09:31:08 INFO - 'LANGUAGE': 'en_US:en', 09:31:08 INFO - 'LOGNAME': 'cltbld', 09:31:08 INFO - 'MAIL': '/var/mail/cltbld', 09:31:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:08 INFO - 'MOZ_NO_REMOTE': '1', 09:31:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:08 INFO - 'NO_EM_RESTART': '1', 09:31:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:08 INFO - 'PWD': '/builds/slave/test', 09:31:08 INFO - 'SHELL': '/bin/bash', 09:31:08 INFO - 'SHLVL': '1', 09:31:08 INFO - 'TERM': 'linux', 09:31:08 INFO - 'TMOUT': '86400', 09:31:08 INFO - 'USER': 'cltbld', 09:31:08 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014', 09:31:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:08 INFO - '_': '/tools/buildbot/bin/python'} 09:31:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:08 INFO - Downloading/unpacking jsonschema==2.5.1 09:31: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 09:31: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 09:31: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 09:31: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 09:31:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:31:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:31: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 09:31: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 09:31: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 09:31: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 09:31:10 INFO - Downloading functools32-3.2.3-2.tar.gz 09:31:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:31:10 INFO - warning: no files found matching '*.txt' 09:31:10 INFO - no previously-included directories found matching 'build' 09:31:10 INFO - no previously-included directories found matching 'dist' 09:31:10 INFO - no previously-included directories found matching '.git*' 09:31:10 INFO - Installing collected packages: jsonschema, functools32 09:31:10 INFO - Running setup.py install for functools32 09:31:10 INFO - warning: no files found matching '*.txt' 09:31:10 INFO - no previously-included directories found matching 'build' 09:31:10 INFO - no previously-included directories found matching 'dist' 09:31:10 INFO - no previously-included directories found matching '.git*' 09:31:10 INFO - Successfully installed jsonschema functools32 09:31:10 INFO - Cleaning up... 09:31:10 INFO - Return code: 0 09:31:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17bc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b38140>, '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 0x1b38a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b38ed0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014', '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 09:31:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:31:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:31:10 INFO - Using env: {'DISPLAY': ':0', 09:31:10 INFO - 'HOME': '/home/cltbld', 09:31:10 INFO - 'LANG': 'en_US.UTF-8', 09:31:10 INFO - 'LANGUAGE': 'en_US:en', 09:31:10 INFO - 'LOGNAME': 'cltbld', 09:31:10 INFO - 'MAIL': '/var/mail/cltbld', 09:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:10 INFO - 'MOZ_NO_REMOTE': '1', 09:31:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:10 INFO - 'NO_EM_RESTART': '1', 09:31:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:10 INFO - 'PWD': '/builds/slave/test', 09:31:10 INFO - 'SHELL': '/bin/bash', 09:31:10 INFO - 'SHLVL': '1', 09:31:10 INFO - 'TERM': 'linux', 09:31:10 INFO - 'TMOUT': '86400', 09:31:10 INFO - 'USER': 'cltbld', 09:31:10 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014', 09:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:10 INFO - '_': '/tools/buildbot/bin/python'} 09:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:31:10 INFO - Cleaning up... 09:31:10 INFO - Return code: 0 09:31:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x17bc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b38140>, '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 0x1b38a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b38ed0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014', '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 09:31:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:31:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:31:10 INFO - Using env: {'DISPLAY': ':0', 09:31:10 INFO - 'HOME': '/home/cltbld', 09:31:10 INFO - 'LANG': 'en_US.UTF-8', 09:31:10 INFO - 'LANGUAGE': 'en_US:en', 09:31:10 INFO - 'LOGNAME': 'cltbld', 09:31:10 INFO - 'MAIL': '/var/mail/cltbld', 09:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:10 INFO - 'MOZ_NO_REMOTE': '1', 09:31:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:10 INFO - 'NO_EM_RESTART': '1', 09:31:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:10 INFO - 'PWD': '/builds/slave/test', 09:31:10 INFO - 'SHELL': '/bin/bash', 09:31:10 INFO - 'SHLVL': '1', 09:31:10 INFO - 'TERM': 'linux', 09:31:10 INFO - 'TMOUT': '86400', 09:31:10 INFO - 'USER': 'cltbld', 09:31:10 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014', 09:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:10 INFO - '_': '/tools/buildbot/bin/python'} 09:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:10 INFO - Downloading/unpacking blobuploader==1.2.4 09:31: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 09:31: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 09:31: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 09:31: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 09:31:11 INFO - Downloading blobuploader-1.2.4.tar.gz 09:31:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:31:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:31:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:12 INFO - Downloading docopt-0.6.1.tar.gz 09:31:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:31:12 INFO - Installing collected packages: blobuploader, requests, docopt 09:31:12 INFO - Running setup.py install for blobuploader 09:31:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:31:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:31:12 INFO - Running setup.py install for requests 09:31:12 INFO - Running setup.py install for docopt 09:31:13 INFO - Successfully installed blobuploader requests docopt 09:31:13 INFO - Cleaning up... 09:31:13 INFO - Return code: 0 09:31:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:31:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:31:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:13 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 0x17bc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b38140>, '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 0x1b38a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b38ed0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014', '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 09:31:13 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 09:31:13 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 09:31:13 INFO - Using env: {'DISPLAY': ':0', 09:31:13 INFO - 'HOME': '/home/cltbld', 09:31:13 INFO - 'LANG': 'en_US.UTF-8', 09:31:13 INFO - 'LANGUAGE': 'en_US:en', 09:31:13 INFO - 'LOGNAME': 'cltbld', 09:31:13 INFO - 'MAIL': '/var/mail/cltbld', 09:31:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:13 INFO - 'MOZ_NO_REMOTE': '1', 09:31:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:13 INFO - 'NO_EM_RESTART': '1', 09:31:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:13 INFO - 'PWD': '/builds/slave/test', 09:31:13 INFO - 'SHELL': '/bin/bash', 09:31:13 INFO - 'SHLVL': '1', 09:31:13 INFO - 'TERM': 'linux', 09:31:13 INFO - 'TMOUT': '86400', 09:31:13 INFO - 'USER': 'cltbld', 09:31:13 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014', 09:31:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:13 INFO - '_': '/tools/buildbot/bin/python'} 09:31:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:31:13 INFO - Running setup.py (path:/tmp/pip-m5vZdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:31:13 INFO - Running setup.py (path:/tmp/pip-hUUTf6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:31:13 INFO - Running setup.py (path:/tmp/pip-6NRQJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:31:13 INFO - Running setup.py (path:/tmp/pip-D3_SI1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:31:13 INFO - Running setup.py (path:/tmp/pip-YQtguy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:31:13 INFO - Running setup.py (path:/tmp/pip-081F8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:31:13 INFO - Running setup.py (path:/tmp/pip-zED0C5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:31:13 INFO - Running setup.py (path:/tmp/pip-BngUOH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:31:13 INFO - Running setup.py (path:/tmp/pip-f3qVqV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:31:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:31:13 INFO - Running setup.py (path:/tmp/pip-2hgQne-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:31:14 INFO - Running setup.py (path:/tmp/pip-bJbbU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:31:14 INFO - Running setup.py (path:/tmp/pip-9CcY1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:31:14 INFO - Running setup.py (path:/tmp/pip-EtPYH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:31:14 INFO - Running setup.py (path:/tmp/pip-2K27RT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:31:14 INFO - Running setup.py (path:/tmp/pip-0Texnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:31:14 INFO - Running setup.py (path:/tmp/pip-Ovn4Qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:31:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:31:14 INFO - Running setup.py (path:/tmp/pip-QaQv6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:31:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:31:14 INFO - Running setup.py install for manifestparser 09:31:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:31:14 INFO - Running setup.py install for mozcrash 09:31:14 INFO - Running setup.py install for mozdebug 09:31:14 INFO - Running setup.py install for mozdevice 09:31:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:31:14 INFO - Running setup.py install for mozfile 09:31:15 INFO - Running setup.py install for mozhttpd 09:31:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:31:15 INFO - Running setup.py install for mozinfo 09:31:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:31:15 INFO - Running setup.py install for mozInstall 09:31:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:31:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:31:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:31:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:31:15 INFO - Running setup.py install for mozleak 09:31:15 INFO - Running setup.py install for mozlog 09:31:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:31:15 INFO - Running setup.py install for moznetwork 09:31:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:31:15 INFO - Running setup.py install for mozprocess 09:31:15 INFO - Running setup.py install for mozprofile 09:31:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:31:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:31:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:31:15 INFO - Running setup.py install for mozrunner 09:31:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:31:16 INFO - Running setup.py install for mozscreenshot 09:31:16 INFO - Running setup.py install for moztest 09:31:16 INFO - Running setup.py install for mozversion 09:31:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:31:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:31:16 INFO - Cleaning up... 09:31:16 INFO - Return code: 0 09:31:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:31:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:31:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:16 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 0x17bc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b38140>, '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 0x1b38a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b38ed0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014', '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 09:31:16 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 09:31:16 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 09:31:16 INFO - Using env: {'DISPLAY': ':0', 09:31:16 INFO - 'HOME': '/home/cltbld', 09:31:16 INFO - 'LANG': 'en_US.UTF-8', 09:31:16 INFO - 'LANGUAGE': 'en_US:en', 09:31:16 INFO - 'LOGNAME': 'cltbld', 09:31:16 INFO - 'MAIL': '/var/mail/cltbld', 09:31:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:16 INFO - 'MOZ_NO_REMOTE': '1', 09:31:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:16 INFO - 'NO_EM_RESTART': '1', 09:31:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:16 INFO - 'PWD': '/builds/slave/test', 09:31:16 INFO - 'SHELL': '/bin/bash', 09:31:16 INFO - 'SHLVL': '1', 09:31:16 INFO - 'TERM': 'linux', 09:31:16 INFO - 'TMOUT': '86400', 09:31:16 INFO - 'USER': 'cltbld', 09:31:16 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014', 09:31:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:16 INFO - '_': '/tools/buildbot/bin/python'} 09:31:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:31:16 INFO - Running setup.py (path:/tmp/pip-73xcak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:31:16 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)) 09:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:31:16 INFO - Running setup.py (path:/tmp/pip-xoPjkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:31:16 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)) 09:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:31:16 INFO - Running setup.py (path:/tmp/pip-_pxSFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:31:16 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)) 09:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:31:16 INFO - Running setup.py (path:/tmp/pip-ehGAeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:31:16 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)) 09:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:31:16 INFO - Running setup.py (path:/tmp/pip-1ZDG77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:31:16 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)) 09:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:31:16 INFO - Running setup.py (path:/tmp/pip-FipNyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:31:16 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)) 09:31:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:31:16 INFO - Running setup.py (path:/tmp/pip-VruwcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:31:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.10 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:31:17 INFO - Running setup.py (path:/tmp/pip-fPk5hw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:31:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.13 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)) 09:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:31:17 INFO - Running setup.py (path:/tmp/pip-rs6hZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:31:17 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)) 09:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:31:17 INFO - Running setup.py (path:/tmp/pip-Z0vpC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:31:17 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)) 09:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:31:17 INFO - Running setup.py (path:/tmp/pip-_dKzsD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:31:17 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)) 09:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:31:17 INFO - Running setup.py (path:/tmp/pip-qM0aHi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:31:17 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)) 09:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:31:17 INFO - Running setup.py (path:/tmp/pip-4vCyUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:31:17 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)) 09:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:31:17 INFO - Running setup.py (path:/tmp/pip-mwE8RR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:31:17 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)) 09:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:31:17 INFO - Running setup.py (path:/tmp/pip-NzFoZ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:31:17 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)) 09:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:31:17 INFO - Running setup.py (path:/tmp/pip-0oaTjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:31:17 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)) 09:31:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:31:17 INFO - Running setup.py (path:/tmp/pip-yNn4Ld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:31:17 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)) 09:31:17 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)) 09:31:17 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)) 09:31:17 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)) 09:31:17 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)) 09:31:17 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)) 09:31:17 INFO - Requirement already satisfied (use --upgrade to upgrade): requests in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozInstall==1.13->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:31:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:18 INFO - Downloading blessings-1.6.tar.gz 09:31:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:31:18 INFO - Installing collected packages: blessings 09:31:18 INFO - Running setup.py install for blessings 09:31:19 INFO - Successfully installed blessings 09:31:19 INFO - Cleaning up... 09:31:19 INFO - Return code: 0 09:31:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:31:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:31:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:31:19 INFO - Reading from file tmpfile_stdout 09:31:19 INFO - Current package versions: 09:31:19 INFO - argparse == 1.2.1 09:31:19 INFO - blessings == 1.6 09:31:19 INFO - blobuploader == 1.2.4 09:31:19 INFO - docopt == 0.6.1 09:31:19 INFO - functools32 == 3.2.3-2 09:31:19 INFO - jsonschema == 2.5.1 09:31:19 INFO - manifestparser == 1.1 09:31:19 INFO - mozInstall == 1.13 09:31:19 INFO - mozcrash == 1.0 09:31:19 INFO - mozdebug == 0.1 09:31:19 INFO - mozdevice == 0.51 09:31:19 INFO - mozfile == 1.2 09:31:19 INFO - mozhttpd == 0.7 09:31:19 INFO - mozinfo == 0.10 09:31:19 INFO - mozleak == 0.1 09:31:19 INFO - mozlog == 3.4 09:31:19 INFO - moznetwork == 0.27 09:31:19 INFO - mozprocess == 0.25 09:31:19 INFO - mozprofile == 0.28 09:31:19 INFO - mozrunner == 6.13 09:31:19 INFO - mozscreenshot == 0.1 09:31:19 INFO - mozsystemmonitor == 0.3 09:31:19 INFO - moztest == 0.8 09:31:19 INFO - mozversion == 1.4 09:31:19 INFO - psutil == 3.1.1 09:31:19 INFO - requests == 1.2.3 09:31:19 INFO - wsgiref == 0.1.2 09:31:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:31: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')]} 09:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31: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')]} 09:31:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:19 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 0x17bc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b38140>, '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 0x1b38a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b38ed0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014', '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 09:31:19 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 09:31:19 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 09:31:19 INFO - Using env: {'DISPLAY': ':0', 09:31:19 INFO - 'HOME': '/home/cltbld', 09:31:19 INFO - 'LANG': 'en_US.UTF-8', 09:31:19 INFO - 'LANGUAGE': 'en_US:en', 09:31:19 INFO - 'LOGNAME': 'cltbld', 09:31:19 INFO - 'MAIL': '/var/mail/cltbld', 09:31:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:19 INFO - 'MOZ_NO_REMOTE': '1', 09:31:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:19 INFO - 'NO_EM_RESTART': '1', 09:31:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:19 INFO - 'PWD': '/builds/slave/test', 09:31:19 INFO - 'SHELL': '/bin/bash', 09:31:19 INFO - 'SHLVL': '1', 09:31:19 INFO - 'TERM': 'linux', 09:31:19 INFO - 'TMOUT': '86400', 09:31:19 INFO - 'USER': 'cltbld', 09:31:19 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014', 09:31:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:19 INFO - '_': '/tools/buildbot/bin/python'} 09:31:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:19 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)) 09:31:19 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)) 09:31:19 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)) 09:31:19 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)) 09:31:19 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)) 09:31:19 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)) 09:31:19 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)) 09:31:19 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)) 09:31:19 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)) 09:31:19 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 09:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:31:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:31:20 INFO - Downloading marionette_driver-1.4.0.tar.gz 09:31:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 09:31:20 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)) 09:31:20 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)) 09:31:20 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)) 09:31:20 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)) 09:31:20 INFO - Installing collected packages: marionette-driver 09:31:20 INFO - Running setup.py install for marionette-driver 09:31:20 INFO - Successfully installed marionette-driver 09:31:20 INFO - Cleaning up... 09:31:20 INFO - Return code: 0 09:31:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:31:20 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')]} 09:31:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:31:20 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')]} 09:31:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:31:20 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 0x17bc3b0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1996a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b3a9a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b38140>, '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 0x1b38a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b38ed0>, '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': '769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014', '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 09:31:20 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 09:31:20 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 09:31:20 INFO - Using env: {'DISPLAY': ':0', 09:31:20 INFO - 'HOME': '/home/cltbld', 09:31:20 INFO - 'LANG': 'en_US.UTF-8', 09:31:20 INFO - 'LANGUAGE': 'en_US:en', 09:31:20 INFO - 'LOGNAME': 'cltbld', 09:31:20 INFO - 'MAIL': '/var/mail/cltbld', 09:31:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:20 INFO - 'MOZ_NO_REMOTE': '1', 09:31:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:20 INFO - 'NO_EM_RESTART': '1', 09:31:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:20 INFO - 'PWD': '/builds/slave/test', 09:31:20 INFO - 'SHELL': '/bin/bash', 09:31:20 INFO - 'SHLVL': '1', 09:31:20 INFO - 'TERM': 'linux', 09:31:20 INFO - 'TMOUT': '86400', 09:31:20 INFO - 'USER': 'cltbld', 09:31:20 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014', 09:31:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:20 INFO - '_': '/tools/buildbot/bin/python'} 09:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:31:21 INFO - Cleaning up... 09:31:21 INFO - Return code: 0 09:31:21 INFO - Running post-action listener: _resource_record_post_action 09:31:21 INFO - Running post-action listener: _start_resource_monitoring 09:31:21 INFO - Starting resource monitoring. 09:31:21 INFO - [mozharness: 2017-07-18 16:31:21.127271Z] Finished create-virtualenv step (success) 09:31:21 INFO - [mozharness: 2017-07-18 16:31:21.127780Z] Running install step. 09:31:21 INFO - Running pre-action listener: _resource_record_pre_action 09:31:21 INFO - Running main action method: install 09:31:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:31:21 INFO - Reading from file tmpfile_stdout 09:31:21 INFO - Detecting whether we're running mozinstall >=1.0... 09:31:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:31:21 INFO - Reading from file tmpfile_stdout 09:31:21 INFO - Output received: 09:31:21 INFO - Usage: mozinstall [options] installer 09:31:21 INFO - Options: 09:31:21 INFO - -h, --help show this help message and exit 09:31:21 INFO - -d DEST, --destination=DEST 09:31:21 INFO - Directory to install application into. [default: 09:31:21 INFO - "/builds/slave/test"] 09:31:21 INFO - --app=APP Application being installed. [default: firefox] 09:31:21 INFO - mkdir: /builds/slave/test/build/application 09:31:21 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'] 09:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:31:38 INFO - Reading from file tmpfile_stdout 09:31:38 INFO - Output received: 09:31:38 INFO - /builds/slave/test/build/application/firefox/firefox 09:31:38 INFO - Running post-action listener: _resource_record_post_action 09:31:38 INFO - [mozharness: 2017-07-18 16:31:38.171648Z] Finished install step (success) 09:31:38 INFO - [mozharness: 2017-07-18 16:31:38.171925Z] Running setup-mitmproxy step. 09:31:38 INFO - Running pre-action listener: _resource_record_pre_action 09:31:38 INFO - Running main action method: setup_mitmproxy 09:31:38 INFO - Skipping: mitmproxy is not required 09:31:38 INFO - Running post-action listener: _resource_record_post_action 09:31:38 INFO - [mozharness: 2017-07-18 16:31:38.173251Z] Finished setup-mitmproxy step (success) 09:31:38 INFO - [mozharness: 2017-07-18 16:31:38.173474Z] Running run-tests step. 09:31:38 INFO - Running pre-action listener: _resource_record_pre_action 09:31:38 INFO - Running main action method: run_tests 09:31:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:31:38 INFO - Python 2.7.3 09:31:38 INFO - Return code: 0 09:31:38 INFO - grabbing minidump binary from tooltool 09:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:31:38 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 0x1b38140>, '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 0x1b38a40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b38ed0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:31:38 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 09:31:38 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 09:31:38 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 09:31:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:31:38 INFO - Return code: 0 09:31:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:31:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:31:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:31:38 INFO - ENV: RUST_BACKTRACE is now 1 09:31:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:31:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:31:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 09:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 09:31:38 INFO - Using env: {'DISPLAY': ':0', 09:31:38 INFO - 'HOME': '/home/cltbld', 09:31:38 INFO - 'LANG': 'en_US.UTF-8', 09:31:38 INFO - 'LANGUAGE': 'en_US:en', 09:31:38 INFO - 'LOGNAME': 'cltbld', 09:31:38 INFO - 'MAIL': '/var/mail/cltbld', 09:31:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:31:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:31:38 INFO - 'MOZ_NO_REMOTE': '1', 09:31:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:31:38 INFO - 'NO_EM_RESTART': '1', 09:31:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:31:38 INFO - 'PWD': '/builds/slave/test', 09:31:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:31:38 INFO - 'RUST_BACKTRACE': '1', 09:31:38 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 09:31:38 INFO - 'SHELL': '/bin/bash', 09:31:38 INFO - 'SHLVL': '1', 09:31:38 INFO - 'TERM': 'linux', 09:31:38 INFO - 'TMOUT': '86400', 09:31:38 INFO - 'USER': 'cltbld', 09:31:38 INFO - 'XDG_SESSION_COOKIE': '769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014', 09:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:31:38 INFO - '_': '/tools/buildbot/bin/python'} 09:31:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 09:31:38 INFO - mozversion application_buildid: 20170718153726 09:31:38 INFO - mozversion application_changeset: 760d9091f2d4fd1131b7455365861eeda2e6ba8f 09:31:38 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:31:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:31:38 INFO - mozversion application_name: Firefox 09:31:38 INFO - mozversion application_remotingname: firefox-dev 09:31:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 09:31:38 INFO - mozversion application_vendor: Mozilla 09:31:38 INFO - mozversion application_version: 55.0 09:31:38 INFO - mozversion platform_buildid: 20170718153726 09:31:38 INFO - mozversion platform_changeset: 760d9091f2d4fd1131b7455365861eeda2e6ba8f 09:31:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 09:31:38 INFO - mozversion platform_version: 55.0 09:31:38 INFO - using testdate: 1500395498 09:31:38 INFO - actual date: 1500395498 09:31:38 INFO - starting webserver on 'localhost:34514' 09:31:38 INFO - SUITE-START | Running 2 tests 09:31:38 INFO - TEST-START | dromaeo_css 09:31:38 INFO - operating with platform_type : linux_ 09:31:38 INFO - Initialising browser for dromaeo_css test... 09:31:38 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34514/getInfo.html -profile /tmp/tmp8vyzFb/profile 09:31:38 INFO - TEST-INFO | started process 12308 (/builds/slave/test/build/application/firefox/firefox http://localhost:34514/getInfo.html) 09:32:13 INFO - TEST-INFO | 12308: killed by SIGTERM 09:32:13 INFO - Browser initialized. 09:32:13 INFO - Running cycle 1/1 for dromaeo_css test... 09:32:13 INFO - TEST-INFO | started process 12512 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8vyzFb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:32:24 INFO - PID 12512 | RSS: Main: 157962240 09:32:24 INFO - PID 12512 | 09:35:26 INFO - PID 12512 | Cycle 1(1): loaded http://localhost:34514/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34514/tests/dromaeo/cssquery-ext.html) 09:35:27 INFO - PID 12512 | RSS: Main: 164986880 09:35:27 INFO - PID 12512 | 09:38:29 INFO - PID 12512 | Cycle 1(1): loaded http://localhost:34514/tests/dromaeo/cssquery-ext.html (next: http://localhost:34514/tests/dromaeo/cssquery-jquery.html) 09:38:29 INFO - PID 12512 | RSS: Main: 165376000 09:38:29 INFO - PID 12512 | 09:41:31 INFO - PID 12512 | Cycle 1(1): loaded http://localhost:34514/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34514/tests/dromaeo/cssquery-mootools.html) 09:41:32 INFO - PID 12512 | RSS: Main: 165232640 09:41:32 INFO - PID 12512 | 09:44:33 INFO - PID 12512 | Cycle 1(1): loaded http://localhost:34514/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34514/tests/dromaeo/cssquery-prototype.html) 09:44:34 INFO - PID 12512 | RSS: Main: 168947712 09:44:34 INFO - PID 12512 | 09:47:36 INFO - PID 12512 | Cycle 1(1): loaded http://localhost:34514/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34514/tests/dromaeo/cssquery-yui.html) 09:47:37 INFO - PID 12512 | RSS: Main: 169308160 09:47:37 INFO - PID 12512 | 09:50:38 INFO - PID 12512 | Cycle 1(1): loaded http://localhost:34514/tests/dromaeo/cssquery-yui.html (next: http://localhost:34514/tests/dromaeo/cssquery-dojo.html) 09:50:39 INFO - PID 12512 | RSS: Main: 165539840 09:50:39 INFO - PID 12512 | 09:50:39 INFO - PID 12512 | __start_tp_report 09:50:39 INFO - PID 12512 | _x_x_mozilla_page_load 09:50:39 INFO - PID 12512 | _x_x_mozilla_page_load_details 09:50:39 INFO - PID 12512 | |i|pagename|runs| 09:50:39 INFO - PID 12512 | |0;dojo.html;3398.0825177202173;3488.0407887830847;3491.1795728003913;3512.1746389598447;3537.6462353764628;5968.701564921753;5972.104184372341;5974.223350964374;5989.940100598993;6062.424069713381;6020.247469066367;6023;6026.638401695901;6035.668038257894;6087.634741915488;5322.973385133078;5357.651752636086;5364.329458817648;5382.757775900074;5461.563074953994;5384.273123128386;5389.380221274564;5398;5406.053940560406;5410.431904650014;5187.247849061902;5278.340207474066;5283.1546952487415;5325.281087053276;5353.0899747043095;5370.57035437168;5403.972980135113;5406.837529931084;5433.8369848904595;5448.782048718046;5342.439043900374;5387.78448862045;5393.73031348435;5396.946030539723;5406.297181366436;5949.762009519614;5966;5987.161797348374;6001.639901605918;6010.57925945184;6412.23053233615;6502.60984340941;6504.739810407578;6515.381038801306;6603.636799976;6602.86794264112;6605.405513503808;6618.900716489256;6627.80116596498;6633.734650613969;6103.298120716175;6177.660228687376;6180.042093475518;6184.19605451293;6186.876262474725;6540.771073012422;6659.500537459709;6760.0535924970545;6773.288804675537;6777.322267773183;6206.038064099981;6216.005439129717;6399.13611662429;6489.253735820346;6489.902651460232;6604.702788374535;6611.305812889674;6613.76851810194;6615.437687796495;6616.603003819786;6484.254310754323;6485.67571621417;6490.610563366213;6579.769708060195;6595.70319335631;6472.935270647234;6487.3836985486305;6491.156149700509;6492.772752953624;6559.409653131241;4829.66192366538;4902.901941961212;4912.582430493448;4927.43334516528;4933.629977751683;4370;4465.843695470643;4482.75344856036;4515.1195516873895;4515.593596576324;6250.624962502265;6251.249850018027;6269.937300627026;6276.592021518587;6288.371162883675;6636.734530618721;6641.203055633355;6649.46804255668;6651.800445986628;6654.467642588581;6126.846828829315;6175.3824617538785;6179.721912513947;6266.342034086447;6280.309165991737;5552.3892371839065;5605.467480589337;5621;5631.549476041907;5640.379558248589;6835.624040677711;6871.03805467235;6872.10662613847;6875.724971001104;6875.931240687529;6566.474682025331;6644.534882558368;6659.334066593302;6670.533062685759;6671.166104236971;6837.760678376233;6854.6229957352825;6863.931360686329;6866.725330986905;6866.793996180123;6316.936830631818;6423.454006409321;6424.261209960728;6439.484841212598;6553.311902250386;6611.107500487373;6661.533692641468;6664.83337916556;6669.233038200669;6687.297833727389;6466.515011374072;6471.158749362553;6480.57876238043;6482.773102941374;6492.805215843532;6447.709853056717;6456.031595260749;6462.224533056064;6467.191601049869;6468.482521398183;6224.906626400517;6295.307516173309;6295.905561416674;6301.243850737941;6438.291787903233;6481.8703625928165;6483.4164925156965;6489.156409666713;6500.739970401131;6505.7072431741635;6276.089966954857;6334.90497642545;6338.746450141943;6343.55595108338;6345.397187267202 09:50:39 INFO - PID 12512 | |1;ext.html;831.1273163178661;867.2888231650046;868.0841711993844;900.0279697926238;919.1681528216958;38089.61910380899;39050.804745976304;39102.41346379803;39175.80412097935;39234.60765392345;36077.45883811745;36373.45439818405;36419.81790091046;36422.81788591053;36427.271454570895;6486.675666216682;6600.9339906601035;6607.5044371672075;6636.170478690164;6636.435902948255;6591.176102987127;6633.502487313447;6678.2987786282465;6684.598924064548;6694.163229596301;6674.032265321525;6708.49686273529;6709.630970296632;6711.094002309675;6716.798496045127;6603.273639899631;7253.492255542114;7437.219091995316;7444.36722878556;7451.143118541383;7322.450816188807;7330.81672958175;7405.481616286862;7413.258674132598;7414.851702965964;36605.08487287839;36946.8152659235;36961.81519092414;36965.815170924245;37012.62987370146;3570.5001299817786;3605.3330133925047;3606.04439823447;3610.205754733954;3631.3282042821897;27736;27746.306342341402;27769.86115069432;27775;27783.30541736473;3696.8336424860945;3741.681957033655;3754.7183961202745;3790.2798468290935;3813.58050614435;179554;179674.10162949233;181196;215151;215660;47317;47491;48134.27798583024;48168.518314817105;48239.27641085387;49215.75392123016;49422.50577494251;49463;49485;49522.50477495179;16423.91788041076;16451.83548164527;16588.170591470378;16630.66738665244;16700.164991750364;13590.932045339909;13637.863621363858;13649.931750341384;13674.179549227078;13686.794698079537;14559.85440145585;14620.268986550629;14646.194459304628;14713.779293310608;14730.042547234396;5612.691301978431;5675.233843431167;5704.11586204139;5745.626534275342;5804.361520232771;1044.237706474263;1049.5277125293496;1057.5663977769232;1065.6217042949797;1069.903708666208;23743.7625623745;24433.144839930515;25017.87491062533;25071.247862564152;25124.623130653054;1185.2651356159236;1186.3119390753343;1195.8564972203392;1200.5197920831563;1211.660734994203;13239.933800330937;13288;13313.40089695966;13470.326483675777;13479.123856949267;284206;284653;285558;286491;286494;51689.483105169216;51797;51862.48137518652;52027.73986130121;52057.7397113012;1429.6997630497503;1492.7238460884555;1498.6328349554428;1511.5843143135726;1512.8789696824228;23956.40108997289;28822.135335939955;29458.705412945597;29603.555946661247;29637;46959.765201173774;48139.518604814904;48415.5158448411;48431.757841210565;48470.75764621155;206399;207973;208077;208383;208902;28301.150965471068;29507;29648.110556683336;31947.520787188674;32850.50724239091;39884.2023159541;40239.597604023584;40342;40467.3929891046;41329.380059299736;28897.85551072231;30089.247768805955;30322.355637486395;30843.228919277197;30867.2283192913;31189.84405078051;31206.21984450316;31216.687833121377;31670.366592667557;32159.51760723638;37040.444393333586;38143.42784858174;38227.42658860175;38415.23169536538;38474.230515390096;29586.704132959258;30926.53610195894;31198.532022020143;31358.37283254368;31679;24361;25318;25519.6172057423;26067.348316292246;26397.868010659822 09:50:39 INFO - PID 12512 | |2;jquery.html;531.7766538054017;534.9893002139958;543.8015124479566;560.7532685618328;560.9803656872009;20946;21542.569148617036;21679.132834686614;21684.457888552795;21691.02390392432;24108.517829643395;25112.246632601007;25872.09447669332;25994.870025649892;26244.212673619822;5948.137520059599;6063.54523410746;6069.848253793646;6082.756689732405;6086.695665216722;6031.396860313956;6088.36072212418;6088.4215999479975;6091.725872335734;6101.328853826076;5710.743016564244;6024.638521688713;6035.336113027563;6054.273487181545;6055.364186760393;6018.729157187915;6049.848753781147;6051.788187413464;6069.241344831896;6074.96962515189;5603.803866864681;5619.6066275360745;5622.775088996476;5637.577181711388;5645.8588535286535;28895.133146005654;29169;29201.123966281044;29238.122856314345;29273.268168295752;2214.202886960693;2274.72703275608;2276.5333106713083;2282.931512054641;2290.5189910118893;19018.52453688655;19163.90418047915;19262.614747704967;19325.9033704832;19405.02974851252;2351.1535847095033;2364.207990323244;2417.2023232333463;2424.0425032112394;2430.793382562484;128869.35565322207;132548;132569;132659;134199;14782.934692959307;15250.23748812555;15403.614909627126;15485.509202331423;15527;22738.886305568696;22785.658215126787;22873.885630572073;22889.198878039188;22966.65550016751;10527.94736026315;10789.784204315869;10917.344959302309;10940.12479001678;10957;10061.899381006242;10069.748256293651;10083.344582602107;10209.591616335412;10218.131458826083;9200.447973121634;9369.297302702325;9451.810963780687;9508.239340852715;9635;2683.1413947536603;2693.9461210776067;2735.343517555812;2794.5528715405844;2864.2123416060335;990.3909095905966;990.4948476277151;1042.4579218806177;1045.320541647935;1056.3872953686844;21482.355529334145;21714.13143474275;21988.670169947465;21996.230131945304;24865.751342486707;1017.7455636090978;1032.1123833503182;1032.7418145463635;1055.1769619696495;1065.7815147894662;11370.431478426046;11468.655940321803;11700.531978720755;11759.118066144902;11831.645050648494;517255;533060;538557;542538;543363;113201.43399283115;113400;113757;114483.42758286322;121682;1303.2636560343376;1328.8073229381685;1348.5212749473992;1358.3276278242333;1360.31984007996;17577.648447031243;18836.905815470836;18870.622587547896;19013.524661883563;19203.423897283104;55040.44959550353;55136.72431637816;57945;57945.42054579569;58886.116708250265;75970.4444787673;76358.23641763511;77308.61345693236;77521.22478775366;77768.22231777836;12196.024318054711;13021.283829389475;13138.868611313765;13239.602811915658;13272.469101235842;18951.526211844262;19256.614867702847;19267.13297901626;19417.805821941598;19522.023898805288;16076.598085047968;16111.758323624921;16240.106794125964;16273.674526509167;16521.421750238685;13337.66655833612;14165.575032749033;14222.146671199762;14407.279636017947;14514.709705806035;16194.67610647804;16509.422170223985;16720;17307.653846922738;17389.47831565055;12990.545330913372;13063.673408164872;13078.411471483616;13178.60464186076;13182.406791694206;15393.538193854203;16430.507084786997;16554.42059527959;16556.172191390142;16579.171041447637 09:50:39 INFO - PID 12512 | |3;mootools.html;1421.410114802357;1488.5980785188005;1501.6245938515378;1502.5792778022158;1519.3314941425767;13820.861791382084;14395.784063239034;14524.273786310681;14570.781438278407;14588.708225835477;13724.862751372484;14145.71708565828;14630.561083167522;14633.341499632515;14664.633384165401;2766.170148955315;2830.3490197254646;2834.1922552072665;2834.9149525514163;2836.3901761121356;2779.833210007396;2809.5785632155134;2823.322402623376;2828.8444135572536;2830.7876909231786;2721.537338652434;2767.33583939855;2792.4415116976684;2792.706765789593;2808.073335799181;2754.807163498556;2865.126136528358;2867.6702179249446;2868.6557613086356;2876.3240638449947;2566.589345704697;2603.6615240018864;2608.7260837612157;2610.164747280871;2620.6069089636517;14286.785698214535;14479.855201448061;14499.492517761828;14531.854681453156;14539.200343981076;7824.960875195645;8081.43429959903;8103.513789172668;8115.269625733712;8117.0665373481625;4367.803448844777;4543.454785425737;4687.9531204687855;4710.74090924999;4743.715377077387;1644.3176081925985;1645.5310236582516;1660.0786563457277;1675.1205617051023;1683.4528778147028;23572.05711771527;23667.644985325234;23862.880685596636;23894.64158037631;23920;6673.766418175341;6783.830404239933;6836.794896153124;6959.164900211906;7019.473539484559;16527.091009994565;16808.15959202035;16816.24326905292;16819.32722691103;16828.074455904796;7489.700411983568;7618.733344333033;7629.961850190713;7641.426892982938;7656.61716914152;6868.828279293058;6959.0257363969085;7083.504154709224;7256.274372562807;7326.743563975236;5321.787128514893;5463.016657001778;5497.972510137503;5612.579056570692;5770.798022069292;1591.1964457948893;1602.1588665950237;1611.0897343001402;1625.3336132185984;1625.918704064792;869.452245085592;874.776931882366;881.8104107616894;881.8324518341494;902.9548522573845;7246.420286377077;7294.489385743053;7388.261173882676;7392.22381649919;8163.265306122477;736.9373603243785;739.8446326271436;746.3693179263514;765.1927216786344;773.9845203095906;4872.610191184696;5352.571794256528;5365;5423.538999185034;5440.537554307928;19474.318398856256;20526.178952841718;20630.381088567367;20675.276365327143;20712.48218794512;19742.50643733918;20258.189672413235;20291.289804857053;20408.693869591967;20657.380278591667;11034.282771619819;11246.1565382595;11385.943070284595;11448.713782155513;11593.130515211393;7975.162607926084;8174.591270436335;8175.959120204361;8189.344852411912;8207.876881846896;16726.163691815116;17238.741418878475;17424.564385890455;17456;17648.382306619205;17475.38836140729;18169.818301816813;18250.452486425427;18329.3584724534;18484.72272915934;10065.949670251603;10898.727531811768;10953.233273671085;10996.395198264172;11027.83458248111;13263.469461221828;13406.731865362834;13411.932940335237;13418.597442076752;13424.127431716906;10829.945850270698;11061.281016733887;11321.943390282995;11470.254433461798;11508.88491115078;10977.3962432067;11064.280821746883;11109.722256943642;11488.195826292414;11655.30068195911;8673.392862499564;8732.301415886586;8735.91264087351;8804.075572064841;8812.823743524965;7027.508074434741;7167.892481612885;7182.461315401261;7214.422846172189;7314.414846812136;6809.761658341934;6904.447644188554;6923.861522769617;7102.5028248022145;7125.287471252833 09:50:39 INFO - PID 12512 | |4;prototype.html;482.70796168318145;496.42662724553156;505.6081536808973;514.6140394703971;519.779093885099;6147.754089836401;6299.905501417483;6311.558190926637;6337.493000559962;6338.239411270654;6066.30237522685;6117.1741814855095;6166.4450199482035;6186.969065154679;6189.10258012589;4892;4892.412910450751;4895.828645997391;4909.8036078557;4921.114199444099;4902.0931127741305;4915.705057696532;4920.3357546731095;4940.937698394844;4944.480829512903;4788.521147885219;4894.265860120975;4894.779734911937;4898.853034408973;4946.678465899723;4893.779779909894;4902.460729319772;4925.950740492585;4936.654434189608;4950.405951285833;4411.09572537629;4418.469783625953;4419.9337009944875;4421.872422532266;4429.025614364835;6121.01067153177;6126.356732543063;6130.601510901822;6133.987891997815;6140.600860944024;5840.3575606683235;5845.123231515264;5853;5858.355580886099;5910.143029260733;6733.326667333227;6739.932600674028;6740.191177058784;6755.987171417442;6771.221309549415;5015.974920125376;5042.445331013586;5045.495450454961;5048.545630893201;5057.115004874132;6940;7008;7039.788806335818;7075.646217689146;7079.646017699094;5172.560332371715;5176.948230517722;5178.482151784867;5179.8446046618665;5211.921821172686;5252.711100889412;5257.974694934527;5259.316288882421;5259.894802104013;5270.78916843322;5847.181394604759;5874.118882167623;5886.911696324559;5887.322957859816;5929.347771745104;6591.371242374482;6739.393454589111;6753.864922701617;6765.2896445872475;6789.490788190906;1800.7028840241214;1802.5763945472804;1819.7543331650058;1821.1531637788491;1830.5515148788631;1163.30201878872;1226.4358395138158;1241.6523373455448;1269.0989397527858;1278.769821432151;6273.560850740496;6278.591891527036;6282.623042617458;6383;6464.191976003;6882;6885.345892140239;6887.827804304932;6892;6897.3447522485285;6412.647304398303;6427.646479443582;6433.292337842833;6450.225972883284;6467.385598368148;3605.4231322988194;3614.1326081740194;3626.9818650906577;3663.6885864701267;3665.651763082503;7100.443840217517;7108.218096009435;7109.680064397115;7113.253108423541;7128.429725621938;6985.720571177096;6991.685374158175;6993.2657071007825;7033.577985320897;7042.6126563039525;7058.9294107059295;7080.893786593205;7102.437463757965;7102.680379382837;7103.964480177669;6758.4931130166415;6810.965945170243;6827.385535301847;6847.1783385994;6863.965680171567;6740.988851672289;6746.730130794714;6760.695768690322;6767.830804229737;6770.289119642367;6689.46484281266;6713.899291510729;7044.647767611701;7045.295470452914;7074.823129421806;5047.268146118866;5075.5178258065425;5079.441261461162;5092.439831618445;5101.51535604117;6786.185657721105;6871.622060786504;6915.308469153246;6921.861562768616;6934.237233904368;6687.966560167168;6724.7646332378135;6727.091842601382;6729.226138994079;6734.292899245509;6666.333366663295;6691.5315927884585;6704.988503448848;6716.194056713226;6724.495662825406;6679.432248258952;6683.465322774264;6695.966520167368;6712.2616512184595;6732.596044237362;6688.197416310074;6731.788278109987;6734.124563806674;6752.797416077526;6758.256591774999;6514.6416947068365;6516.446102081376;6521.8695626088165;6531.150950376421;6554.508411869034 09:50:39 INFO - PID 12512 | |5;yui.html;843.3042739739716;846.699421705295;868.7524055644138;870.8214815962727;878.8945326560812;17123.22945467454;17900.194491247894;17922.462326130222;20005.699914501292;20931.476713082182;19439.028048597585;19571.706424403645;19669.803301966975;19759.604807903834;19891.403257902286;958.185542289054;962.8170647576973;987.0327079462131;991.9752006199831;994.0804755601076;1019.286499450384;1020.4234607446806;1023.4268809466722;1023.749181450542;1024.8975102489728;1026.2405819693447;1065.4033741104968;1065.9200559957994;1066.6693325069252;1067.6903697927592;1042.838360054189;1045.2578669144877;1048;1049.2864851900704;1049.4018409506584;746.4961151222902;748.4461498491132;755.199488542147;757.0839284465803;757.7613051888637;17727.379541716105;17888.821111788977;17895.642087158183;17982;18320.908395457936;19340.903295483575;19496.51258718529;19807.60384792296;19922.103505342293;19982;15345;15636.296366663413;15685.372585096582;15750.9212453937;15788.842111578851;3527.5943266524423;3528.6824185823143;3541.8583256669704;3545.3795585772386;3556.342076715816;110113;110132.4493377528;113232;116119;117479;15184.696306074038;15480;15491.767623485657;15523.844761552466;15725.606859828367;27762.444751104864;27971.44057118846;28209.858950705526;29287.707122928925;29299.85350073236;7841.333486653698;8002.399820013406;8102.918970810217;8107.918920810835;8110.797230069295;3838;4155.459790227251;4304.16068866568;4324.502682191525;4327.740335579875;4863.10032643962;4962.578180854668;4971.204607262821;4974.303597496353;4987.1771157759285;982.2829334585649;994.5126887825058;1001.4191768774093;1004.6785028790863;1009.1069403577886;707.85135121624;709.3048812164108;715.2489885620079;721.585088574072;741.5587725303436;12613;12721.55474558386;12806.167599106027;13112;13165;716.8136284565946;719.363363423374;720.7873677265219;721.6680327049615;741.7515132430697;5957.553183511167;6030.6080104793045;6081.057436097412;6096.603720758137;6242.625442473466;119511.40244298722;120740;123283;123346;127053;99134;104907.4754626222;104954.47522762338;106462.46768766262;110093;85551.57224213963;86132.56933715292;89613.55193224123;89824;90605.54697226471;11730.237534560227;11869.643910682693;11918.40407979615;12138.878611214128;12359.196652217577;43694.78152609216;44873.326900095875;45056;45701;46928;54169.72915135399;54988.45011549833;55729.721351394604;57568.712156440626;58049.4195058044;15728.685426291639;16082.115483648511;16088.597785055466;18092.54768630795;19031;17084.48746537606;21377.144914203258;21819.345419637437;21950.121995120015;21957.890210548845;18803.623927521647;19198.424047278604;19275.61448771045;19521.414357569294;19857.801421985594;17467.56331091733;18659.72010419872;18837.340693075676;18953.526161846064;18997.33509327222;17726.911365443608;18684.439466816017;18693.158807853408;18989.810101898805;19078;11331.546738130382;11871.465784039567;12275.938620307199;12286.38568071575;12362.44369003415;14379.137251764927;14932.253387330808;14980.925095374454;14995.625109372353;15087.396504139711 09:50:39 INFO - PID 12512 | __end_tp_report 09:50:39 INFO - PID 12512 | __start_cc_report 09:50:39 INFO - PID 12512 | _x_x_mozilla_cycle_collect,290 09:50:39 INFO - PID 12512 | __end_cc_report 09:50:39 INFO - PID 12512 | __startTimestamp1500396639188__endTimestamp 09:50:39 INFO - PID 12512 | 09:50:39 INFO - PID 12512 | ------- Summary: start ------- 09:50:39 INFO - PID 12512 | Number of tests: 6 09:50:39 INFO - PID 12512 | 09:50:39 INFO - PID 12512 | [#0] dojo.html Cycles:165 Average:6060.06 Median:6316.94 stddev:742.61 (11.8%) stddev-sans-first:714.92 09:50:39 INFO - PID 12512 | Values: 3398.1 3488.0 3491.2 3512.2 3537.6 5968.7 5972.1 5974.2 5989.9 6062.4 6020.2 6023.0 6026.6 6035.7 6087.6 5323.0 5357.7 5364.3 5382.8 5461.6 5384.3 5389.4 5398.0 5406.1 5410.4 5187.2 5278.3 5283.2 5325.3 5353.1 5370.6 5404.0 5406.8 5433.8 5448.8 5342.4 5387.8 5393.7 5396.9 5406.3 5949.8 5966.0 5987.2 6001.6 6010.6 6412.2 6502.6 6504.7 6515.4 6603.6 6602.9 6605.4 6618.9 6627.8 6633.7 6103.3 6177.7 6180.0 6184.2 6186.9 6540.8 6659.5 6760.1 6773.3 6777.3 6206.0 6216.0 6399.1 6489.3 6489.9 6604.7 6611.3 6613.8 6615.4 6616.6 6484.3 6485.7 6490.6 6579.8 6595.7 6472.9 6487.4 6491.2 6492.8 6559.4 4829.7 4902.9 4912.6 4927.4 4933.6 4370.0 4465.8 4482.8 4515.1 4515.6 6250.6 6251.2 6269.9 6276.6 6288.4 6636.7 6641.2 6649.5 6651.8 6654.5 6126.8 6175.4 6179.7 6266.3 6280.3 5552.4 5605.5 5621.0 5631.5 5640.4 6835.6 6871.0 6872.1 6875.7 6875.9 6566.5 6644.5 6659.3 6670.5 6671.2 6837.8 6854.6 6863.9 6866.7 6866.8 6316.9 6423.5 6424.3 6439.5 6553.3 6611.1 6661.5 6664.8 6669.2 6687.3 6466.5 6471.2 6480.6 6482.8 6492.8 6447.7 6456.0 6462.2 6467.2 6468.5 6224.9 6295.3 6295.9 6301.2 6438.3 6481.9 6483.4 6489.2 6500.7 6505.7 6276.1 6334.9 6338.7 6343.6 6345.4 09:50:39 INFO - PID 12512 | 09:50:39 INFO - PID 12512 | [#1] ext.html Cycles:180 Average:39318.45 Median:3587.92 stddev:60706.11 (1692.0%) stddev-sans-first:60807.62 09:50:39 INFO - PID 12512 | Values: 831.1 867.3 868.1 900.0 919.2 38089.6 39050.8 39102.4 39175.8 39234.6 36077.5 36373.5 36419.8 36422.8 36427.3 6486.7 6600.9 6607.5 6636.2 6636.4 6591.2 6633.5 6678.3 6684.6 6694.2 6674.0 6708.5 6709.6 6711.1 6716.8 6603.3 7253.5 7437.2 7444.4 7451.1 7322.5 7330.8 7405.5 7413.3 7414.9 36605.1 36946.8 36961.8 36965.8 37012.6 3570.5 3605.3 3606.0 3610.2 3631.3 27736.0 27746.3 27769.9 27775.0 27783.3 3696.8 3741.7 3754.7 3790.3 3813.6 179554.0 179674.1 181196.0 215151.0 215660.0 47317.0 47491.0 48134.3 48168.5 48239.3 49215.8 49422.5 49463.0 49485.0 49522.5 16423.9 16451.8 16588.2 16630.7 16700.2 13590.9 13637.9 13649.9 13674.2 13686.8 14559.9 14620.3 14646.2 14713.8 14730.0 5612.7 5675.2 5704.1 5745.6 5804.4 1044.2 1049.5 1057.6 1065.6 1069.9 23743.8 24433.1 25017.9 25071.2 25124.6 1185.3 1186.3 1195.9 1200.5 1211.7 13239.9 13288.0 13313.4 13470.3 13479.1 284206.0 284653.0 285558.0 286491.0 286494.0 51689.5 51797.0 51862.5 52027.7 52057.7 1429.7 1492.7 1498.6 1511.6 1512.9 23956.4 28822.1 29458.7 29603.6 29637.0 46959.8 48139.5 48415.5 48431.8 48470.8 206399.0 207973.0 208077.0 208383.0 208902.0 28301.2 29507.0 29648.1 31947.5 32850.5 39884.2 40239.6 40342.0 40467.4 41329.4 28897.9 30089.2 30322.4 30843.2 30867.2 31189.8 31206.2 31216.7 31670.4 32159.5 37040.4 38143.4 38227.4 38415.2 38474.2 29586.7 30926.5 31198.5 31358.4 31679.0 24361.0 25318.0 25519.6 26067.3 26397.9 09:50:39 INFO - PID 12512 | 09:50:39 INFO - PID 12512 | [#2] jquery.html Cycles:180 Average:35640.22 Median:21610.85 stddev:89506.07 (414.2%) stddev-sans-first:89718.34 09:50:39 INFO - PID 12512 | Values: 531.8 535.0 543.8 560.8 561.0 20946.0 21542.6 21679.1 21684.5 21691.0 24108.5 25112.2 25872.1 25994.9 26244.2 5948.1 6063.5 6069.8 6082.8 6086.7 6031.4 6088.4 6088.4 6091.7 6101.3 5710.7 6024.6 6035.3 6054.3 6055.4 6018.7 6049.8 6051.8 6069.2 6075.0 5603.8 5619.6 5622.8 5637.6 5645.9 28895.1 29169.0 29201.1 29238.1 29273.3 2214.2 2274.7 2276.5 2282.9 2290.5 19018.5 19163.9 19262.6 19325.9 19405.0 2351.2 2364.2 2417.2 2424.0 2430.8 128869.4 132548.0 132569.0 132659.0 134199.0 14782.9 15250.2 15403.6 15485.5 15527.0 22738.9 22785.7 22873.9 22889.2 22966.7 10527.9 10789.8 10917.3 10940.1 10957.0 10061.9 10069.7 10083.3 10209.6 10218.1 9200.4 9369.3 9451.8 9508.2 9635.0 2683.1 2693.9 2735.3 2794.6 2864.2 990.4 990.5 1042.5 1045.3 1056.4 21482.4 21714.1 21988.7 21996.2 24865.8 1017.7 1032.1 1032.7 1055.2 1065.8 11370.4 11468.7 11700.5 11759.1 11831.6 517255.0 533060.0 538557.0 542538.0 543363.0 113201.4 113400.0 113757.0 114483.4 121682.0 1303.3 1328.8 1348.5 1358.3 1360.3 17577.6 18836.9 18870.6 19013.5 19203.4 55040.4 55136.7 57945.0 57945.4 58886.1 75970.4 76358.2 77308.6 77521.2 77768.2 12196.0 13021.3 13138.9 13239.6 13272.5 18951.5 19256.6 19267.1 19417.8 19522.0 16076.6 16111.8 16240.1 16273.7 16521.4 13337.7 14165.6 14222.1 14407.3 14514.7 16194.7 16509.4 16720.0 17307.7 17389.5 12990.5 13063.7 13078.4 13178.6 13182.4 15393.5 16430.5 16554.4 16556.2 16579.2 09:50:39 INFO - PID 12512 | 09:50:39 INFO - PID 12512 | [#3] mootools.html Cycles:180 Average:8936.80 Median:2738.17 stddev:6196.33 (226.3%) stddev-sans-first:6187.98 09:50:39 INFO - PID 12512 | Values: 1421.4 1488.6 1501.6 1502.6 1519.3 13820.9 14395.8 14524.3 14570.8 14588.7 13724.9 14145.7 14630.6 14633.3 14664.6 2766.2 2830.3 2834.2 2834.9 2836.4 2779.8 2809.6 2823.3 2828.8 2830.8 2721.5 2767.3 2792.4 2792.7 2808.1 2754.8 2865.1 2867.7 2868.7 2876.3 2566.6 2603.7 2608.7 2610.2 2620.6 14286.8 14479.9 14499.5 14531.9 14539.2 7825.0 8081.4 8103.5 8115.3 8117.1 4367.8 4543.5 4688.0 4710.7 4743.7 1644.3 1645.5 1660.1 1675.1 1683.5 23572.1 23667.6 23862.9 23894.6 23920.0 6673.8 6783.8 6836.8 6959.2 7019.5 16527.1 16808.2 16816.2 16819.3 16828.1 7489.7 7618.7 7630.0 7641.4 7656.6 6868.8 6959.0 7083.5 7256.3 7326.7 5321.8 5463.0 5498.0 5612.6 5770.8 1591.2 1602.2 1611.1 1625.3 1625.9 869.5 874.8 881.8 881.8 903.0 7246.4 7294.5 7388.3 7392.2 8163.3 736.9 739.8 746.4 765.2 774.0 4872.6 5352.6 5365.0 5423.5 5440.5 19474.3 20526.2 20630.4 20675.3 20712.5 19742.5 20258.2 20291.3 20408.7 20657.4 11034.3 11246.2 11385.9 11448.7 11593.1 7975.2 8174.6 8176.0 8189.3 8207.9 16726.2 17238.7 17424.6 17456.0 17648.4 17475.4 18169.8 18250.5 18329.4 18484.7 10065.9 10898.7 10953.2 10996.4 11027.8 13263.5 13406.7 13411.9 13418.6 13424.1 10829.9 11061.3 11321.9 11470.3 11508.9 10977.4 11064.3 11109.7 11488.2 11655.3 8673.4 8732.3 8735.9 8804.1 8812.8 7027.5 7167.9 7182.5 7214.4 7314.4 6809.8 6904.4 6923.9 7102.5 7125.3 09:50:39 INFO - PID 12512 | 09:50:39 INFO - PID 12512 | [#4] prototype.html Cycles:180 Average:5673.84 Median:6324.53 stddev:1624.84 (25.7%) stddev-sans-first:1582.00 09:50:39 INFO - PID 12512 | Values: 482.7 496.4 505.6 514.6 519.8 6147.8 6299.9 6311.6 6337.5 6338.2 6066.3 6117.2 6166.4 6187.0 6189.1 4892.0 4892.4 4895.8 4909.8 4921.1 4902.1 4915.7 4920.3 4940.9 4944.5 4788.5 4894.3 4894.8 4898.9 4946.7 4893.8 4902.5 4926.0 4936.7 4950.4 4411.1 4418.5 4419.9 4421.9 4429.0 6121.0 6126.4 6130.6 6134.0 6140.6 5840.4 5845.1 5853.0 5858.4 5910.1 6733.3 6739.9 6740.2 6756.0 6771.2 5016.0 5042.4 5045.5 5048.5 5057.1 6940.0 7008.0 7039.8 7075.6 7079.6 5172.6 5176.9 5178.5 5179.8 5211.9 5252.7 5258.0 5259.3 5259.9 5270.8 5847.2 5874.1 5886.9 5887.3 5929.3 6591.4 6739.4 6753.9 6765.3 6789.5 1800.7 1802.6 1819.8 1821.2 1830.6 1163.3 1226.4 1241.7 1269.1 1278.8 6273.6 6278.6 6282.6 6383.0 6464.2 6882.0 6885.3 6887.8 6892.0 6897.3 6412.6 6427.6 6433.3 6450.2 6467.4 3605.4 3614.1 3627.0 3663.7 3665.7 7100.4 7108.2 7109.7 7113.3 7128.4 6985.7 6991.7 6993.3 7033.6 7042.6 7058.9 7080.9 7102.4 7102.7 7104.0 6758.5 6811.0 6827.4 6847.2 6864.0 6741.0 6746.7 6760.7 6767.8 6770.3 6689.5 6713.9 7044.6 7045.3 7074.8 5047.3 5075.5 5079.4 5092.4 5101.5 6786.2 6871.6 6915.3 6921.9 6934.2 6688.0 6724.8 6727.1 6729.2 6734.3 6666.3 6691.5 6705.0 6716.2 6724.5 6679.4 6683.5 6696.0 6712.3 6732.6 6688.2 6731.8 6734.1 6752.8 6758.3 6514.6 6516.4 6521.9 6531.2 6554.5 09:50:39 INFO - PID 12512 | 09:50:39 INFO - PID 12512 | [#5] yui.html Cycles:180 Average:23552.55 Median:19467.77 stddev:32338.68 (166.1%) stddev-sans-first:32384.44 09:50:39 INFO - PID 12512 | Values: 843.3 846.7 868.8 870.8 878.9 17123.2 17900.2 17922.5 20005.7 20931.5 19439.0 19571.7 19669.8 19759.6 19891.4 958.2 962.8 987.0 992.0 994.1 1019.3 1020.4 1023.4 1023.7 1024.9 1026.2 1065.4 1065.9 1066.7 1067.7 1042.8 1045.3 1048.0 1049.3 1049.4 746.5 748.4 755.2 757.1 757.8 17727.4 17888.8 17895.6 17982.0 18320.9 19340.9 19496.5 19807.6 19922.1 19982.0 15345.0 15636.3 15685.4 15750.9 15788.8 3527.6 3528.7 3541.9 3545.4 3556.3 110113.0 110132.4 113232.0 116119.0 117479.0 15184.7 15480.0 15491.8 15523.8 15725.6 27762.4 27971.4 28209.9 29287.7 29299.9 7841.3 8002.4 8102.9 8107.9 8110.8 3838.0 4155.5 4304.2 4324.5 4327.7 4863.1 4962.6 4971.2 4974.3 4987.2 982.3 994.5 1001.4 1004.7 1009.1 707.9 709.3 715.2 721.6 741.6 12613.0 12721.6 12806.2 13112.0 13165.0 716.8 719.4 720.8 721.7 741.8 5957.6 6030.6 6081.1 6096.6 6242.6 119511.4 120740.0 123283.0 123346.0 127053.0 99134.0 104907.5 104954.5 106462.5 110093.0 85551.6 86132.6 89613.6 89824.0 90605.5 11730.2 11869.6 11918.4 12138.9 12359.2 43694.8 44873.3 45056.0 45701.0 46928.0 54169.7 54988.5 55729.7 57568.7 58049.4 15728.7 16082.1 16088.6 18092.5 19031.0 17084.5 21377.1 21819.3 21950.1 21957.9 18803.6 19198.4 19275.6 19521.4 19857.8 17467.6 18659.7 18837.3 18953.5 18997.3 17726.9 18684.4 18693.2 18989.8 19078.0 11331.5 11871.5 12275.9 12286.4 12362.4 14379.1 14932.3 14980.9 14995.6 15087.4 09:50:39 INFO - PID 12512 | -------- Summary: end -------- 09:50:39 INFO - PID 12512 | 09:50:40 INFO - TEST-INFO | 12512: exit 0 09:50:40 INFO - TEST-OK | dromaeo_css | took 1141550ms 09:50:40 INFO - TEST-START | kraken 09:50:40 INFO - operating with platform_type : linux_ 09:50:40 INFO - Initialising browser for kraken test... 09:50:40 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:34514/getInfo.html -profile /tmp/tmpI0vO9A/profile 09:50:40 INFO - TEST-INFO | started process 12917 (/builds/slave/test/build/application/firefox/firefox http://localhost:34514/getInfo.html) 09:51:14 INFO - TEST-INFO | 12917: killed by SIGTERM 09:51:14 INFO - Browser initialized. 09:51:14 INFO - Running cycle 1/1 for kraken test... 09:51:14 INFO - TEST-INFO | started process 13122 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI0vO9A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:51:26 INFO - PID 13122 | RSS: Main: 158035968 09:51:26 INFO - PID 13122 | 09:51:28 INFO - PID 13122 | Cycle 1(1): loaded http://localhost:34514/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34514/tests/kraken/driver.html?testName=audio-beat-detection) 09:51:29 INFO - PID 13122 | RSS: Main: 163147776 09:51:29 INFO - PID 13122 | 09:51:31 INFO - PID 13122 | Cycle 1(1): loaded http://localhost:34514/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34514/tests/kraken/driver.html?testName=audio-dft) 09:51:32 INFO - PID 13122 | RSS: Main: 163819520 09:51:32 INFO - PID 13122 | 09:51:35 INFO - PID 13122 | Cycle 1(1): loaded http://localhost:34514/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34514/tests/kraken/driver.html?testName=audio-fft) 09:51:35 INFO - PID 13122 | RSS: Main: 165208064 09:51:35 INFO - PID 13122 | 09:51:38 INFO - PID 13122 | Cycle 1(1): loaded http://localhost:34514/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34514/tests/kraken/driver.html?testName=audio-oscillator) 09:51:38 INFO - PID 13122 | RSS: Main: 165904384 09:51:38 INFO - PID 13122 | 09:51:40 INFO - PID 13122 | Cycle 1(1): loaded http://localhost:34514/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34514/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:51:41 INFO - PID 13122 | RSS: Main: 165396480 09:51:41 INFO - PID 13122 | 09:51:44 INFO - PID 13122 | Cycle 1(1): loaded http://localhost:34514/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34514/tests/kraken/driver.html?testName=imaging-darkroom) 09:51:44 INFO - PID 13122 | RSS: Main: 165617664 09:51:44 INFO - PID 13122 | 09:51:48 INFO - PID 13122 | Cycle 1(1): loaded http://localhost:34514/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34514/tests/kraken/driver.html?testName=imaging-desaturate) 09:51:48 INFO - PID 13122 | RSS: Main: 165576704 09:51:48 INFO - PID 13122 | 09:51:51 INFO - PID 13122 | Cycle 1(1): loaded http://localhost:34514/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34514/tests/kraken/driver.html?testName=json-parse-financial) 09:51:52 INFO - PID 13122 | RSS: Main: 165990400 09:51:52 INFO - PID 13122 | 09:51:53 INFO - PID 13122 | Cycle 1(1): loaded http://localhost:34514/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34514/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:51:54 INFO - PID 13122 | RSS: Main: 165027840 09:51:54 INFO - PID 13122 | 09:51:56 INFO - PID 13122 | Cycle 1(1): loaded http://localhost:34514/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34514/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:51:56 INFO - PID 13122 | RSS: Main: 165199872 09:51:56 INFO - PID 13122 | 09:51:58 INFO - PID 13122 | Cycle 1(1): loaded http://localhost:34514/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34514/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:51:59 INFO - PID 13122 | RSS: Main: 165498880 09:51:59 INFO - PID 13122 | 09:52:01 INFO - PID 13122 | Cycle 1(1): loaded http://localhost:34514/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34514/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:52:02 INFO - PID 13122 | RSS: Main: 165281792 09:52:02 INFO - PID 13122 | 09:52:05 INFO - PID 13122 | Cycle 1(1): loaded http://localhost:34514/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34514/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:52:05 INFO - PID 13122 | RSS: Main: 165310464 09:52:05 INFO - PID 13122 | 09:52:07 INFO - PID 13122 | Cycle 1(1): loaded http://localhost:34514/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34514/tests/kraken/driver.html?testName=ai-astar) 09:52:07 INFO - PID 13122 | RSS: Main: 167256064 09:52:07 INFO - PID 13122 | 09:52:07 INFO - PID 13122 | __start_tp_report 09:52:07 INFO - PID 13122 | _x_x_mozilla_page_load 09:52:07 INFO - PID 13122 | _x_x_mozilla_page_load_details 09:52:07 INFO - PID 13122 | |i|pagename|runs| 09:52:07 INFO - PID 13122 | |0;ai-astar;98;110;99;107;112;113;112;99;108;107 09:52:07 INFO - PID 13122 | |1;audio-beat-detection;150;117;142;178;116;152;140;116;168;116 09:52:07 INFO - PID 13122 | |2;audio-dft;163;163;161;164;163;161;163;160;175;165 09:52:07 INFO - PID 13122 | |3;audio-fft;73;75;74;188;74;74;74;76;160;78 09:52:07 INFO - PID 13122 | |4;audio-oscillator;82;82;136;82;82;81;127;81;80;135 09:52:07 INFO - PID 13122 | |5;imaging-gaussian-blur;114;113;115;114;114;114;114;114;114;114 09:52:07 INFO - PID 13122 | |6;imaging-darkroom;148;149;147;148;149;148;147;146;148;148 09:52:07 INFO - PID 13122 | |7;imaging-desaturate;94;94;93;99;94;94;94;95;95;96 09:52:07 INFO - PID 13122 | |8;json-parse-financial;45;46;46;45;48;44;48;47;44;47 09:52:07 INFO - PID 13122 | |9;json-stringify-tinderbox;52;52;52;52;54;52;53;52;52;53 09:52:07 INFO - PID 13122 | |10;stanford-crypto-aes;73;74;73;75;74;72;74;75;74;74 09:52:07 INFO - PID 13122 | |11;stanford-crypto-ccm;119;122;121;119;126;117;120;119;126;134 09:52:07 INFO - PID 13122 | |12;stanford-crypto-pbkdf2;158;162;168;170;176;163;175;185;179;172 09:52:07 INFO - PID 13122 | |13;stanford-crypto-sha256-iterative;62;63;63;63;62;61;60;61;60;68 09:52:07 INFO - PID 13122 | __end_tp_report 09:52:07 INFO - PID 13122 | __start_cc_report 09:52:07 INFO - PID 13122 | _x_x_mozilla_cycle_collect,760 09:52:07 INFO - PID 13122 | __end_cc_report 09:52:07 INFO - PID 13122 | __startTimestamp1500396727876__endTimestamp 09:52:07 INFO - PID 13122 | 09:52:07 INFO - PID 13122 | ------- Summary: start ------- 09:52:07 INFO - PID 13122 | Number of tests: 14 09:52:07 INFO - PID 13122 | 09:52:07 INFO - PID 13122 | [#0] ai-astar Cycles:10 Average:106.50 Median:112.50 stddev:5.80 (5.2%) stddev-sans-first:5.27 09:52:07 INFO - PID 13122 | Values: 98.0 110.0 99.0 107.0 112.0 113.0 112.0 99.0 108.0 107.0 09:52:07 INFO - PID 13122 | 09:52:07 INFO - PID 13122 | [#1] audio-beat-detection Cycles:10 Average:139.50 Median:146.00 stddev:22.93 (15.7%) stddev-sans-first:24.00 09:52:07 INFO - PID 13122 | Values: 150.0 117.0 142.0 178.0 116.0 152.0 140.0 116.0 168.0 116.0 09:52:07 INFO - PID 13122 | 09:52:07 INFO - PID 13122 | [#2] audio-dft Cycles:10 Average:163.80 Median:163.00 stddev:4.21 (2.6%) stddev-sans-first:4.46 09:52:07 INFO - PID 13122 | Values: 163.0 163.0 161.0 164.0 163.0 161.0 163.0 160.0 175.0 165.0 09:52:07 INFO - PID 13122 | 09:52:07 INFO - PID 13122 | [#3] audio-fft Cycles:10 Average:94.60 Median:74.00 stddev:42.39 (57.3%) stddev-sans-first:44.23 09:52:07 INFO - PID 13122 | Values: 73.0 75.0 74.0 188.0 74.0 74.0 74.0 76.0 160.0 78.0 09:52:07 INFO - PID 13122 | 09:52:07 INFO - PID 13122 | [#4] audio-oscillator Cycles:10 Average:96.80 Median:81.50 stddev:24.87 (30.5%) stddev-sans-first:25.79 09:52:07 INFO - PID 13122 | Values: 82.0 82.0 136.0 82.0 82.0 81.0 127.0 81.0 80.0 135.0 09:52:07 INFO - PID 13122 | 09:52:07 INFO - PID 13122 | [#5] imaging-gaussian-blur Cycles:10 Average:114.00 Median:114.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 09:52:07 INFO - PID 13122 | Values: 114.0 113.0 115.0 114.0 114.0 114.0 114.0 114.0 114.0 114.0 09:52:07 INFO - PID 13122 | 09:52:07 INFO - PID 13122 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 09:52:07 INFO - PID 13122 | Values: 148.0 149.0 147.0 148.0 149.0 148.0 147.0 146.0 148.0 148.0 09:52:07 INFO - PID 13122 | 09:52:07 INFO - PID 13122 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:94.50 stddev:1.69 (1.8%) stddev-sans-first:1.76 09:52:07 INFO - PID 13122 | Values: 94.0 94.0 93.0 99.0 94.0 94.0 94.0 95.0 95.0 96.0 09:52:07 INFO - PID 13122 | 09:52:07 INFO - PID 13122 | [#8] json-parse-financial Cycles:10 Average:46.00 Median:46.50 stddev:1.49 (3.2%) stddev-sans-first:1.54 09:52:07 INFO - PID 13122 | Values: 45.0 46.0 46.0 45.0 48.0 44.0 48.0 47.0 44.0 47.0 09:52:07 INFO - PID 13122 | 09:52:07 INFO - PID 13122 | [#9] json-stringify-tinderbox Cycles:10 Average:52.40 Median:52.00 stddev:0.70 (1.3%) stddev-sans-first:0.73 09:52:07 INFO - PID 13122 | Values: 52.0 52.0 52.0 52.0 54.0 52.0 53.0 52.0 52.0 53.0 09:52:07 INFO - PID 13122 | 09:52:07 INFO - PID 13122 | [#10] stanford-crypto-aes Cycles:10 Average:73.80 Median:74.00 stddev:0.92 (1.2%) stddev-sans-first:0.93 09:52:07 INFO - PID 13122 | Values: 73.0 74.0 73.0 75.0 74.0 72.0 74.0 75.0 74.0 74.0 09:52:07 INFO - PID 13122 | 09:52:07 INFO - PID 13122 | [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:121.50 stddev:5.08 (4.2%) stddev-sans-first:5.24 09:52:07 INFO - PID 13122 | Values: 119.0 122.0 121.0 119.0 126.0 117.0 120.0 119.0 126.0 134.0 09:52:07 INFO - PID 13122 | 09:52:07 INFO - PID 13122 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.80 Median:173.50 stddev:8.34 (4.8%) stddev-sans-first:7.45 09:52:07 INFO - PID 13122 | Values: 158.0 162.0 168.0 170.0 176.0 163.0 175.0 185.0 179.0 172.0 09:52:07 INFO - PID 13122 | 09:52:07 INFO - PID 13122 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.30 Median:62.50 stddev:2.31 (3.7%) stddev-sans-first:2.45 09:52:07 INFO - PID 13122 | Values: 62.0 63.0 63.0 63.0 62.0 61.0 60.0 61.0 60.0 68.0 09:52:07 INFO - PID 13122 | -------- Summary: end -------- 09:52:07 INFO - PID 13122 | 09:52:08 INFO - TEST-INFO | 13122: exit 0 09:52:08 INFO - TEST-OK | kraken | took 88869ms 09:52:08 INFO - SUITE-END | took 1230s 09:52:09 INFO - Completed test suite (00:20:30) 09:52:09 INFO - javascript benchmark 09:52:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8454.479071435086, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3398.0825177202173, 3488.0407887830847, 3491.1795728003913, 3512.1746389598447, 3537.6462353764628, 5968.701564921753, 5972.104184372341, 5974.223350964374, 5989.940100598993, 6062.424069713381, 6020.247469066367, 6023.0, 6026.638401695901, 6035.668038257894, 6087.634741915488, 5322.973385133078, 5357.651752636086, 5364.329458817648, 5382.757775900074, 5461.563074953994, 5384.273123128386, 5389.380221274564, 5398.0, 5406.053940560406, 5410.431904650014, 5187.247849061902, 5278.340207474066, 5283.1546952487415, 5325.281087053276, 5353.0899747043095, 5370.57035437168, 5403.972980135113, 5406.837529931084, 5433.8369848904595, 5448.782048718046, 5342.439043900374, 5387.78448862045, 5393.73031348435, 5396.946030539723, 5406.297181366436, 5949.762009519614, 5966.0, 5987.161797348374, 6001.639901605918, 6010.57925945184, 6412.23053233615, 6502.60984340941, 6504.739810407578, 6515.381038801306, 6603.636799976, 6602.86794264112, 6605.405513503808, 6618.900716489256, 6627.80116596498, 6633.734650613969, 6103.298120716175, 6177.660228687376, 6180.042093475518, 6184.19605451293, 6186.876262474725, 6540.771073012422, 6659.500537459709, 6760.0535924970545, 6773.288804675537, 6777.322267773183, 6206.038064099981, 6216.005439129717, 6399.13611662429, 6489.253735820346, 6489.902651460232, 6604.702788374535, 6611.305812889674, 6613.76851810194, 6615.437687796495, 6616.603003819786, 6484.254310754323, 6485.67571621417, 6490.610563366213, 6579.769708060195, 6595.70319335631, 6472.935270647234, 6487.3836985486305, 6491.156149700509, 6492.772752953624, 6559.409653131241, 4829.66192366538, 4902.901941961212, 4912.582430493448, 4927.43334516528, 4933.629977751683, 4370.0, 4465.843695470643, 4482.75344856036, 4515.1195516873895, 4515.593596576324, 6250.624962502265, 6251.249850018027, 6269.937300627026, 6276.592021518587, 6288.371162883675, 6636.734530618721, 6641.203055633355, 6649.46804255668, 6651.800445986628, 6654.467642588581, 6126.846828829315, 6175.3824617538785, 6179.721912513947, 6266.342034086447, 6280.309165991737, 5552.3892371839065, 5605.467480589337, 5621.0, 5631.549476041907, 5640.379558248589, 6835.624040677711, 6871.03805467235, 6872.10662613847, 6875.724971001104, 6875.931240687529, 6566.474682025331, 6644.534882558368, 6659.334066593302, 6670.533062685759, 6671.166104236971, 6837.760678376233, 6854.6229957352825, 6863.931360686329, 6866.725330986905, 6866.793996180123, 6316.936830631818, 6423.454006409321, 6424.261209960728, 6439.484841212598, 6553.311902250386, 6611.107500487373, 6661.533692641468, 6664.83337916556, 6669.233038200669, 6687.297833727389, 6466.515011374072, 6471.158749362553, 6480.57876238043, 6482.773102941374, 6492.805215843532, 6447.709853056717, 6456.031595260749, 6462.224533056064, 6467.191601049869, 6468.482521398183, 6224.906626400517, 6295.307516173309, 6295.905561416674, 6301.243850737941, 6438.291787903233, 6481.8703625928165, 6483.4164925156965, 6489.156409666713, 6500.739970401131, 6505.7072431741635, 6276.089966954857, 6334.90497642545, 6338.746450141943, 6343.55595108338, 6345.397187267202], "value": 6006.597743745306, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [831.1273163178661, 867.2888231650046, 868.0841711993844, 900.0279697926238, 919.1681528216958, 38089.61910380899, 39050.804745976304, 39102.41346379803, 39175.80412097935, 39234.60765392345, 36077.45883811745, 36373.45439818405, 36419.81790091046, 36422.81788591053, 36427.271454570895, 6486.675666216682, 6600.9339906601035, 6607.5044371672075, 6636.170478690164, 6636.435902948255, 6591.176102987127, 6633.502487313447, 6678.2987786282465, 6684.598924064548, 6694.163229596301, 6674.032265321525, 6708.49686273529, 6709.630970296632, 6711.094002309675, 6716.798496045127, 6603.273639899631, 7253.492255542114, 7437.219091995316, 7444.36722878556, 7451.143118541383, 7322.450816188807, 7330.81672958175, 7405.481616286862, 7413.258674132598, 7414.851702965964, 36605.08487287839, 36946.8152659235, 36961.81519092414, 36965.815170924245, 37012.62987370146, 3570.5001299817786, 3605.3330133925047, 3606.04439823447, 3610.205754733954, 3631.3282042821897, 27736.0, 27746.306342341402, 27769.86115069432, 27775.0, 27783.30541736473, 3696.8336424860945, 3741.681957033655, 3754.7183961202745, 3790.2798468290935, 3813.58050614435, 179554.0, 179674.10162949233, 181196.0, 215151.0, 215660.0, 47317.0, 47491.0, 48134.27798583024, 48168.518314817105, 48239.27641085387, 49215.75392123016, 49422.50577494251, 49463.0, 49485.0, 49522.50477495179, 16423.91788041076, 16451.83548164527, 16588.170591470378, 16630.66738665244, 16700.164991750364, 13590.932045339909, 13637.863621363858, 13649.931750341384, 13674.179549227078, 13686.794698079537, 14559.85440145585, 14620.268986550629, 14646.194459304628, 14713.779293310608, 14730.042547234396, 5612.691301978431, 5675.233843431167, 5704.11586204139, 5745.626534275342, 5804.361520232771, 1044.237706474263, 1049.5277125293496, 1057.5663977769232, 1065.6217042949797, 1069.903708666208, 23743.7625623745, 24433.144839930515, 25017.87491062533, 25071.247862564152, 25124.623130653054, 1185.2651356159236, 1186.3119390753343, 1195.8564972203392, 1200.5197920831563, 1211.660734994203, 13239.933800330937, 13288.0, 13313.40089695966, 13470.326483675777, 13479.123856949267, 284206.0, 284653.0, 285558.0, 286491.0, 286494.0, 51689.483105169216, 51797.0, 51862.48137518652, 52027.73986130121, 52057.7397113012, 1429.6997630497503, 1492.7238460884555, 1498.6328349554428, 1511.5843143135726, 1512.8789696824228, 23956.40108997289, 28822.135335939955, 29458.705412945597, 29603.555946661247, 29637.0, 46959.765201173774, 48139.518604814904, 48415.5158448411, 48431.757841210565, 48470.75764621155, 206399.0, 207973.0, 208077.0, 208383.0, 208902.0, 28301.150965471068, 29507.0, 29648.110556683336, 31947.520787188674, 32850.50724239091, 39884.2023159541, 40239.597604023584, 40342.0, 40467.3929891046, 41329.380059299736, 28897.85551072231, 30089.247768805955, 30322.355637486395, 30843.228919277197, 30867.2283192913, 31189.84405078051, 31206.21984450316, 31216.687833121377, 31670.366592667557, 32159.51760723638, 37040.444393333586, 38143.42784858174, 38227.42658860175, 38415.23169536538, 38474.230515390096, 29586.704132959258, 30926.53610195894, 31198.532022020143, 31358.37283254368, 31679.0, 24361.0, 25318.0, 25519.6172057423, 26067.348316292246, 26397.868010659822], "value": 17042.465432584155, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.7766538054017, 534.9893002139958, 543.8015124479566, 560.7532685618328, 560.9803656872009, 20946.0, 21542.569148617036, 21679.132834686614, 21684.457888552795, 21691.02390392432, 24108.517829643395, 25112.246632601007, 25872.09447669332, 25994.870025649892, 26244.212673619822, 5948.137520059599, 6063.54523410746, 6069.848253793646, 6082.756689732405, 6086.695665216722, 6031.396860313956, 6088.36072212418, 6088.4215999479975, 6091.725872335734, 6101.328853826076, 5710.743016564244, 6024.638521688713, 6035.336113027563, 6054.273487181545, 6055.364186760393, 6018.729157187915, 6049.848753781147, 6051.788187413464, 6069.241344831896, 6074.96962515189, 5603.803866864681, 5619.6066275360745, 5622.775088996476, 5637.577181711388, 5645.8588535286535, 28895.133146005654, 29169.0, 29201.123966281044, 29238.122856314345, 29273.268168295752, 2214.202886960693, 2274.72703275608, 2276.5333106713083, 2282.931512054641, 2290.5189910118893, 19018.52453688655, 19163.90418047915, 19262.614747704967, 19325.9033704832, 19405.02974851252, 2351.1535847095033, 2364.207990323244, 2417.2023232333463, 2424.0425032112394, 2430.793382562484, 128869.35565322207, 132548.0, 132569.0, 132659.0, 134199.0, 14782.934692959307, 15250.23748812555, 15403.614909627126, 15485.509202331423, 15527.0, 22738.886305568696, 22785.658215126787, 22873.885630572073, 22889.198878039188, 22966.65550016751, 10527.94736026315, 10789.784204315869, 10917.344959302309, 10940.12479001678, 10957.0, 10061.899381006242, 10069.748256293651, 10083.344582602107, 10209.591616335412, 10218.131458826083, 9200.447973121634, 9369.297302702325, 9451.810963780687, 9508.239340852715, 9635.0, 2683.1413947536603, 2693.9461210776067, 2735.343517555812, 2794.5528715405844, 2864.2123416060335, 990.3909095905966, 990.4948476277151, 1042.4579218806177, 1045.320541647935, 1056.3872953686844, 21482.355529334145, 21714.13143474275, 21988.670169947465, 21996.230131945304, 24865.751342486707, 1017.7455636090978, 1032.1123833503182, 1032.7418145463635, 1055.1769619696495, 1065.7815147894662, 11370.431478426046, 11468.655940321803, 11700.531978720755, 11759.118066144902, 11831.645050648494, 517255.0, 533060.0, 538557.0, 542538.0, 543363.0, 113201.43399283115, 113400.0, 113757.0, 114483.42758286322, 121682.0, 1303.2636560343376, 1328.8073229381685, 1348.5212749473992, 1358.3276278242333, 1360.31984007996, 17577.648447031243, 18836.905815470836, 18870.622587547896, 19013.524661883563, 19203.423897283104, 55040.44959550353, 55136.72431637816, 57945.0, 57945.42054579569, 58886.116708250265, 75970.4444787673, 76358.23641763511, 77308.61345693236, 77521.22478775366, 77768.22231777836, 12196.024318054711, 13021.283829389475, 13138.868611313765, 13239.602811915658, 13272.469101235842, 18951.526211844262, 19256.614867702847, 19267.13297901626, 19417.805821941598, 19522.023898805288, 16076.598085047968, 16111.758323624921, 16240.106794125964, 16273.674526509167, 16521.421750238685, 13337.66655833612, 14165.575032749033, 14222.146671199762, 14407.279636017947, 14514.709705806035, 16194.67610647804, 16509.422170223985, 16720.0, 17307.653846922738, 17389.47831565055, 12990.545330913372, 13063.673408164872, 13078.411471483616, 13178.60464186076, 13182.406791694206, 15393.538193854203, 16430.507084786997, 16554.42059527959, 16556.172191390142, 16579.171041447637], "value": 11768.135691604624, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1421.410114802357, 1488.5980785188005, 1501.6245938515378, 1502.5792778022158, 1519.3314941425767, 13820.861791382084, 14395.784063239034, 14524.273786310681, 14570.781438278407, 14588.708225835477, 13724.862751372484, 14145.71708565828, 14630.561083167522, 14633.341499632515, 14664.633384165401, 2766.170148955315, 2830.3490197254646, 2834.1922552072665, 2834.9149525514163, 2836.3901761121356, 2779.833210007396, 2809.5785632155134, 2823.322402623376, 2828.8444135572536, 2830.7876909231786, 2721.537338652434, 2767.33583939855, 2792.4415116976684, 2792.706765789593, 2808.073335799181, 2754.807163498556, 2865.126136528358, 2867.6702179249446, 2868.6557613086356, 2876.3240638449947, 2566.589345704697, 2603.6615240018864, 2608.7260837612157, 2610.164747280871, 2620.6069089636517, 14286.785698214535, 14479.855201448061, 14499.492517761828, 14531.854681453156, 14539.200343981076, 7824.960875195645, 8081.43429959903, 8103.513789172668, 8115.269625733712, 8117.0665373481625, 4367.803448844777, 4543.454785425737, 4687.9531204687855, 4710.74090924999, 4743.715377077387, 1644.3176081925985, 1645.5310236582516, 1660.0786563457277, 1675.1205617051023, 1683.4528778147028, 23572.05711771527, 23667.644985325234, 23862.880685596636, 23894.64158037631, 23920.0, 6673.766418175341, 6783.830404239933, 6836.794896153124, 6959.164900211906, 7019.473539484559, 16527.091009994565, 16808.15959202035, 16816.24326905292, 16819.32722691103, 16828.074455904796, 7489.700411983568, 7618.733344333033, 7629.961850190713, 7641.426892982938, 7656.61716914152, 6868.828279293058, 6959.0257363969085, 7083.504154709224, 7256.274372562807, 7326.743563975236, 5321.787128514893, 5463.016657001778, 5497.972510137503, 5612.579056570692, 5770.798022069292, 1591.1964457948893, 1602.1588665950237, 1611.0897343001402, 1625.3336132185984, 1625.918704064792, 869.452245085592, 874.776931882366, 881.8104107616894, 881.8324518341494, 902.9548522573845, 7246.420286377077, 7294.489385743053, 7388.261173882676, 7392.22381649919, 8163.265306122477, 736.9373603243785, 739.8446326271436, 746.3693179263514, 765.1927216786344, 773.9845203095906, 4872.610191184696, 5352.571794256528, 5365.0, 5423.538999185034, 5440.537554307928, 19474.318398856256, 20526.178952841718, 20630.381088567367, 20675.276365327143, 20712.48218794512, 19742.50643733918, 20258.189672413235, 20291.289804857053, 20408.693869591967, 20657.380278591667, 11034.282771619819, 11246.1565382595, 11385.943070284595, 11448.713782155513, 11593.130515211393, 7975.162607926084, 8174.591270436335, 8175.959120204361, 8189.344852411912, 8207.876881846896, 16726.163691815116, 17238.741418878475, 17424.564385890455, 17456.0, 17648.382306619205, 17475.38836140729, 18169.818301816813, 18250.452486425427, 18329.3584724534, 18484.72272915934, 10065.949670251603, 10898.727531811768, 10953.233273671085, 10996.395198264172, 11027.83458248111, 13263.469461221828, 13406.731865362834, 13411.932940335237, 13418.597442076752, 13424.127431716906, 10829.945850270698, 11061.281016733887, 11321.943390282995, 11470.254433461798, 11508.88491115078, 10977.3962432067, 11064.280821746883, 11109.722256943642, 11488.195826292414, 11655.30068195911, 8673.392862499564, 8732.301415886586, 8735.91264087351, 8804.075572064841, 8812.823743524965, 7027.508074434741, 7167.892481612885, 7182.461315401261, 7214.422846172189, 7314.414846812136, 6809.761658341934, 6904.447644188554, 6923.861522769617, 7102.5028248022145, 7125.287471252833], "value": 6462.189346369425, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [482.70796168318145, 496.42662724553156, 505.6081536808973, 514.6140394703971, 519.779093885099, 6147.754089836401, 6299.905501417483, 6311.558190926637, 6337.493000559962, 6338.239411270654, 6066.30237522685, 6117.1741814855095, 6166.4450199482035, 6186.969065154679, 6189.10258012589, 4892.0, 4892.412910450751, 4895.828645997391, 4909.8036078557, 4921.114199444099, 4902.0931127741305, 4915.705057696532, 4920.3357546731095, 4940.937698394844, 4944.480829512903, 4788.521147885219, 4894.265860120975, 4894.779734911937, 4898.853034408973, 4946.678465899723, 4893.779779909894, 4902.460729319772, 4925.950740492585, 4936.654434189608, 4950.405951285833, 4411.09572537629, 4418.469783625953, 4419.9337009944875, 4421.872422532266, 4429.025614364835, 6121.01067153177, 6126.356732543063, 6130.601510901822, 6133.987891997815, 6140.600860944024, 5840.3575606683235, 5845.123231515264, 5853.0, 5858.355580886099, 5910.143029260733, 6733.326667333227, 6739.932600674028, 6740.191177058784, 6755.987171417442, 6771.221309549415, 5015.974920125376, 5042.445331013586, 5045.495450454961, 5048.545630893201, 5057.115004874132, 6940.0, 7008.0, 7039.788806335818, 7075.646217689146, 7079.646017699094, 5172.560332371715, 5176.948230517722, 5178.482151784867, 5179.8446046618665, 5211.921821172686, 5252.711100889412, 5257.974694934527, 5259.316288882421, 5259.894802104013, 5270.78916843322, 5847.181394604759, 5874.118882167623, 5886.911696324559, 5887.322957859816, 5929.347771745104, 6591.371242374482, 6739.393454589111, 6753.864922701617, 6765.2896445872475, 6789.490788190906, 1800.7028840241214, 1802.5763945472804, 1819.7543331650058, 1821.1531637788491, 1830.5515148788631, 1163.30201878872, 1226.4358395138158, 1241.6523373455448, 1269.0989397527858, 1278.769821432151, 6273.560850740496, 6278.591891527036, 6282.623042617458, 6383.0, 6464.191976003, 6882.0, 6885.345892140239, 6887.827804304932, 6892.0, 6897.3447522485285, 6412.647304398303, 6427.646479443582, 6433.292337842833, 6450.225972883284, 6467.385598368148, 3605.4231322988194, 3614.1326081740194, 3626.9818650906577, 3663.6885864701267, 3665.651763082503, 7100.443840217517, 7108.218096009435, 7109.680064397115, 7113.253108423541, 7128.429725621938, 6985.720571177096, 6991.685374158175, 6993.2657071007825, 7033.577985320897, 7042.6126563039525, 7058.9294107059295, 7080.893786593205, 7102.437463757965, 7102.680379382837, 7103.964480177669, 6758.4931130166415, 6810.965945170243, 6827.385535301847, 6847.1783385994, 6863.965680171567, 6740.988851672289, 6746.730130794714, 6760.695768690322, 6767.830804229737, 6770.289119642367, 6689.46484281266, 6713.899291510729, 7044.647767611701, 7045.295470452914, 7074.823129421806, 5047.268146118866, 5075.5178258065425, 5079.441261461162, 5092.439831618445, 5101.51535604117, 6786.185657721105, 6871.622060786504, 6915.308469153246, 6921.861562768616, 6934.237233904368, 6687.966560167168, 6724.7646332378135, 6727.091842601382, 6729.226138994079, 6734.292899245509, 6666.333366663295, 6691.5315927884585, 6704.988503448848, 6716.194056713226, 6724.495662825406, 6679.432248258952, 6683.465322774264, 6695.966520167368, 6712.2616512184595, 6732.596044237362, 6688.197416310074, 6731.788278109987, 6734.124563806674, 6752.797416077526, 6758.256591774999, 6514.6416947068365, 6516.446102081376, 6521.8695626088165, 6531.150950376421, 6554.508411869034], "value": 5189.620411509863, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [843.3042739739716, 846.699421705295, 868.7524055644138, 870.8214815962727, 878.8945326560812, 17123.22945467454, 17900.194491247894, 17922.462326130222, 20005.699914501292, 20931.476713082182, 19439.028048597585, 19571.706424403645, 19669.803301966975, 19759.604807903834, 19891.403257902286, 958.185542289054, 962.8170647576973, 987.0327079462131, 991.9752006199831, 994.0804755601076, 1019.286499450384, 1020.4234607446806, 1023.4268809466722, 1023.749181450542, 1024.8975102489728, 1026.2405819693447, 1065.4033741104968, 1065.9200559957994, 1066.6693325069252, 1067.6903697927592, 1042.838360054189, 1045.2578669144877, 1048.0, 1049.2864851900704, 1049.4018409506584, 746.4961151222902, 748.4461498491132, 755.199488542147, 757.0839284465803, 757.7613051888637, 17727.379541716105, 17888.821111788977, 17895.642087158183, 17982.0, 18320.908395457936, 19340.903295483575, 19496.51258718529, 19807.60384792296, 19922.103505342293, 19982.0, 15345.0, 15636.296366663413, 15685.372585096582, 15750.9212453937, 15788.842111578851, 3527.5943266524423, 3528.6824185823143, 3541.8583256669704, 3545.3795585772386, 3556.342076715816, 110113.0, 110132.4493377528, 113232.0, 116119.0, 117479.0, 15184.696306074038, 15480.0, 15491.767623485657, 15523.844761552466, 15725.606859828367, 27762.444751104864, 27971.44057118846, 28209.858950705526, 29287.707122928925, 29299.85350073236, 7841.333486653698, 8002.399820013406, 8102.918970810217, 8107.918920810835, 8110.797230069295, 3838.0, 4155.459790227251, 4304.16068866568, 4324.502682191525, 4327.740335579875, 4863.10032643962, 4962.578180854668, 4971.204607262821, 4974.303597496353, 4987.1771157759285, 982.2829334585649, 994.5126887825058, 1001.4191768774093, 1004.6785028790863, 1009.1069403577886, 707.85135121624, 709.3048812164108, 715.2489885620079, 721.585088574072, 741.5587725303436, 12613.0, 12721.55474558386, 12806.167599106027, 13112.0, 13165.0, 716.8136284565946, 719.363363423374, 720.7873677265219, 721.6680327049615, 741.7515132430697, 5957.553183511167, 6030.6080104793045, 6081.057436097412, 6096.603720758137, 6242.625442473466, 119511.40244298722, 120740.0, 123283.0, 123346.0, 127053.0, 99134.0, 104907.4754626222, 104954.47522762338, 106462.46768766262, 110093.0, 85551.57224213963, 86132.56933715292, 89613.55193224123, 89824.0, 90605.54697226471, 11730.237534560227, 11869.643910682693, 11918.40407979615, 12138.878611214128, 12359.196652217577, 43694.78152609216, 44873.326900095875, 45056.0, 45701.0, 46928.0, 54169.72915135399, 54988.45011549833, 55729.721351394604, 57568.712156440626, 58049.4195058044, 15728.685426291639, 16082.115483648511, 16088.597785055466, 18092.54768630795, 19031.0, 17084.48746537606, 21377.144914203258, 21819.345419637437, 21950.121995120015, 21957.890210548845, 18803.623927521647, 19198.424047278604, 19275.61448771045, 19521.414357569294, 19857.801421985594, 17467.56331091733, 18659.72010419872, 18837.340693075676, 18953.526161846064, 18997.33509327222, 17726.911365443608, 18684.439466816017, 18693.158807853408, 18989.810101898805, 19078.0, 11331.546738130382, 11871.465784039567, 12275.938620307199, 12286.38568071575, 12362.44369003415, 14379.137251764927, 14932.253387330808, 14980.925095374454, 14995.625109372353, 15087.396504139711], "value": 9038.821280479558, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1485.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 110.0, 99.0, 107.0, 112.0, 113.0, 112.0, 99.0, 108.0, 107.0], "value": 106.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 117.0, 142.0, 178.0, 116.0, 152.0, 140.0, 116.0, 168.0, 116.0], "value": 139.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 164.0, 163.0, 161.0, 163.0, 160.0, 175.0, 165.0], "value": 163.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 75.0, 74.0, 188.0, 74.0, 74.0, 74.0, 76.0, 160.0, 78.0], "value": 94.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 136.0, 82.0, 82.0, 81.0, 127.0, 81.0, 80.0, 135.0], "value": 96.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 115.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 147.0, 148.0, 149.0, 148.0, 147.0, 146.0, 148.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 99.0, 94.0, 94.0, 94.0, 95.0, 95.0, 96.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [45.0, 46.0, 46.0, 45.0, 48.0, 44.0, 48.0, 47.0, 44.0, 47.0], "value": 46.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 52.0, 52.0, 54.0, 52.0, 53.0, 52.0, 52.0, 53.0], "value": 52.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 73.0, 75.0, 74.0, 72.0, 74.0, 75.0, 74.0, 74.0], "value": 73.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 122.0, 121.0, 119.0, 126.0, 117.0, 120.0, 119.0, 126.0, 134.0], "value": 122.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 162.0, 168.0, 170.0, 176.0, 163.0, 175.0, 185.0, 179.0, 172.0], "value": 170.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 63.0, 62.0, 61.0, 60.0, 61.0, 60.0, 68.0], "value": 62.3, "unit": "score"}]}]} 09:52:09 INFO - Return code: 0 09:52:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:52:09 INFO - # TBPL SUCCESS # 09:52:09 INFO - Running post-action listener: _resource_record_post_action 09:52:09 INFO - [mozharness: 2017-07-18 16:52:09.281811Z] Finished run-tests step (success) 09:52:09 INFO - Running post-run listener: _resource_record_post_run 09:52:09 INFO - Total resource usage - Wall time: 1248s; CPU: 12.0%; Read bytes: 765952; Write bytes: 396660736; Read time: 216; Write time: 234056 09:52:09 INFO - TinderboxPrint: CPU usage
12.5% 09:52:09 INFO - TinderboxPrint: I/O read bytes / time
765,952 / 216 09:52:09 INFO - TinderboxPrint: I/O write bytes / time
396,660,736 / 234,056 09:52:09 INFO - TinderboxPrint: CPU idle
8,717.6 (87.5%) 09:52:09 INFO - TinderboxPrint: CPU user
1,192.9 (12.0%) 09:52:09 INFO - TinderboxPrint: Swap in / out
0 / 0 09:52:09 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 101818368; Read time: 0; Write time: 83252 09:52:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 09:52:09 INFO - run-tests - Wall time: 1231s; CPU: 12.0%; Read bytes: 761856; Write bytes: 294027264; Read time: 200; Write time: 150728 09:52:09 INFO - Running post-run listener: _upload_blobber_files 09:52:09 INFO - Blob upload gear active. 09:52:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:52:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:52:09 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:52:09 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:52:10 INFO - Traceback (most recent call last): 09:52:10 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 253, in 09:52:10 INFO - main() 09:52:10 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 235, in main 09:52:10 INFO - filetype_whitelist = get_server_whitelist(args['--url']) 09:52:10 INFO - File "/builds/slave/test/build/venv/bin/blobberc.py", line 69, in get_server_whitelist 09:52:10 INFO - return set(response.json().get('whitelist', [])) 09:52:10 INFO - File "/builds/slave/test/build/venv/local/lib/python2.7/site-packages/requests/models.py", line 651, in json 09:52:10 INFO - return json.loads(self.text or self.content, **kwargs) 09:52:10 INFO - File "/usr/lib/python2.7/json/__init__.py", line 326, in loads 09:52:10 INFO - return _default_decoder.decode(s) 09:52:10 INFO - File "/usr/lib/python2.7/json/decoder.py", line 366, in decode 09:52:10 INFO - obj, end = self.raw_decode(s, idx=_w(s, 0).end()) 09:52:10 INFO - File "/usr/lib/python2.7/json/decoder.py", line 384, in raw_decode 09:52:10 INFO - raise ValueError("No JSON object could be decoded") 09:52:10 INFO - ValueError: No JSON object could be decoded 09:52:10 ERROR - Return code: 1 09:52:10 INFO - Setting buildbot property blobber_files to {} 09:52:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:52:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:52:10 INFO - Contents: 09:52:10 INFO - blobber_files:{} 09:52:10 INFO - Running post-run listener: copy_logs_to_upload_dir 09:52:10 INFO - Copying logs to upload dir... 09:52:10 INFO - mkdir: /builds/slave/test/build/upload/logs 09:52:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1299.445467 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 39 secs) (at 2017-07-18 09:52:10.289840) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-18 09:52:10.292993) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{} build_url:https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011092 build_url: 'https://queue.taskcluster.net/v1/task/Sbgt9NhDT9q9fznE5Nuz-Q/artifacts/public/build/target.tar.bz2' blobber_files: '{}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-18 09:52:10.344091) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 09:52:10.344435) ========= 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=769a0cfe1e83e11e6f11f5a3000001a8-1500392823.27119-1377173014 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004707 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-18 09:52:10.395611) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-18 09:52:10.396036) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-18 09:52:10.396435) ========= ========= Total master_lag: 0.17 =========