builder: cedar_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-059 starttime: 1500989180.43 results: success (0) revision: 8c5ace71270c76e17b884c50e10cbf333d7c33a2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-07-25 06:26:20.431696) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-07-25 06:26:20.432397) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-25 06:26:20.432888) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-07-25 06:26:20.457838) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 06:26:20.458139) ========= 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=3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-07-25 06:26:20-- 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% 85.0M=0s 2017-07-25 06:26:20 (85.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.077920 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 06:26:20.568694) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 06:26:20.569236) ========= 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=3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022930 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 06:26:20.626039) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 06:26:20.626810) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 8c5ace71270c76e17b884c50e10cbf333d7c33a2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo projects/cedar --rev 8c5ace71270c76e17b884c50e10cbf333d7c33a2 --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=3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-07-25 06:26:20,818 truncating revision to first 12 chars 2017-07-25 06:26:20,818 Setting DEBUG logging. 2017-07-25 06:26:20,818 attempt 1/10 2017-07-25 06:26:20,818 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/8c5ace71270c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-07-25 06:26:21,377 unpacking tar archive at: cedar-8c5ace71270c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.856730 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 06:26:21.502152) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-25 06:26:21.502496) ========= script_repo_revision: 8c5ace71270c76e17b884c50e10cbf333d7c33a2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-07-25 06:26:21.502967) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-25 06:26:21.503354) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-07-25 06:26:21.513408) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-07-25 06:26:21.513716) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] 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=3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:26:21 INFO - MultiFileLogger online at 20170725 06:26:21 in /builds/slave/test 06:26:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Cedar --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 06:26:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:26:21 INFO - {'append_to_log': False, 06:26:21 INFO - 'base_work_dir': '/builds/slave/test', 06:26:21 INFO - 'blob_upload_branch': 'Cedar', 06:26:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:26:21 INFO - 'branch': 'Cedar', 06:26:21 INFO - 'buildbot_json_path': 'buildprops.json', 06:26:21 INFO - 'code_coverage': False, 06:26:21 INFO - 'config_files': ('talos/linux_config.py',), 06:26:21 INFO - 'default_actions': ('clobber', 06:26:21 INFO - 'read-buildbot-config', 06:26:21 INFO - 'download-and-extract', 06:26:21 INFO - 'populate-webroot', 06:26:21 INFO - 'create-virtualenv', 06:26:21 INFO - 'install', 06:26:21 INFO - 'setup-mitmproxy', 06:26:21 INFO - 'run-tests'), 06:26:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:26:21 INFO - 'disable_ccov_upload': False, 06:26:21 INFO - 'download_minidump_stackwalk': True, 06:26:21 INFO - 'download_symbols': 'ondemand', 06:26:21 INFO - 'enable_stylo': False, 06:26:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:26:21 INFO - 'tooltool.py': '/tools/tooltool.py', 06:26:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:26:21 INFO - '/tools/misc-python/virtualenv.py')}, 06:26:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:26:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:26:21 INFO - 'gecko_profile': False, 06:26:21 INFO - 'gecko_profile_interval': 0, 06:26:21 INFO - 'installer_path': 'installer.exe', 06:26:21 INFO - 'log_level': 'info', 06:26:21 INFO - 'log_name': 'talos', 06:26:21 INFO - 'log_to_console': True, 06:26:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:26:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:26:21 INFO - 'opt_config_files': (), 06:26:21 INFO - 'pip_index': False, 06:26:21 INFO - 'suite': 'dromaeojs-e10s', 06:26:21 INFO - 'system_bits': '32', 06:26:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:26:21 INFO - 'title': 'talos-linux64-ix-059', 06:26:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:26:21 INFO - 'use_talos_json': True, 06:26:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:26:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:26:21 INFO - 'work_dir': 'build'} 06:26:21 INFO - [mozharness: 2017-07-25 13:26:21.807240Z] Running clobber step. 06:26:21 INFO - Running pre-action listener: _resource_record_pre_action 06:26:21 INFO - Running main action method: clobber 06:26:21 INFO - rmtree: /builds/slave/test/build 06:26:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:26:23 INFO - Running post-action listener: _resource_record_post_action 06:26:23 INFO - [mozharness: 2017-07-25 13:26:23.344205Z] Finished clobber step (success) 06:26:23 INFO - [mozharness: 2017-07-25 13:26:23.344306Z] Running read-buildbot-config step. 06:26:23 INFO - Running pre-action listener: _resource_record_pre_action 06:26:23 INFO - Running main action method: read_buildbot_config 06:26:23 INFO - Using buildbot properties: 06:26:23 INFO - { 06:26:23 INFO - "project": "", 06:26:23 INFO - "product": "firefox", 06:26:23 INFO - "who": "mconley@mozilla.com", 06:26:23 INFO - "installer_path": "public/build/target.tar.bz2", 06:26:23 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs-e10s", 06:26:23 INFO - "repository": "https://hg.mozilla.org/projects/cedar", 06:26:23 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs-e10s", 06:26:23 INFO - "stage_platform": "linux64", 06:26:23 INFO - "basedir": "/builds/slave/test", 06:26:23 INFO - "buildnumber": 14, 06:26:23 INFO - "platform": "ubuntu64_hw", 06:26:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:26:23 INFO - "slavebuilddir": "test", 06:26:23 INFO - "taskId": "D35eVA7bQQS9-mdxiDSuOw", 06:26:23 INFO - "branch": "cedar", 06:26:23 INFO - "script_repo_revision": "default", 06:26:23 INFO - "revision": "8c5ace71270c76e17b884c50e10cbf333d7c33a2", 06:26:23 INFO - "slavename": "talos-linux64-ix-059", 06:26:23 INFO - "repo_path": "projects/cedar" 06:26:23 INFO - } 06:26:23 INFO - Finding installer, test and symbols from parent task. 06:26:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D35eVA7bQQS9-mdxiDSuOw'}, attempt #1 06:26:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D35eVA7bQQS9-mdxiDSuOw'}, attempt #1 06:26:24 INFO - Task dependencies: DxLflJatRvehZ3Q2LSUt3Q 06:26:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q'}, attempt #1 06:26:24 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/target.tar.bz2 06:26:24 INFO - Set test_url: https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/test_packages.json 06:26:24 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/target.crashreporter-symbols.zip 06:26:24 INFO - Running post-action listener: _resource_record_post_action 06:26:24 INFO - [mozharness: 2017-07-25 13:26:24.715612Z] Finished read-buildbot-config step (success) 06:26:24 INFO - [mozharness: 2017-07-25 13:26:24.715833Z] Running download-and-extract step. 06:26:24 INFO - Running pre-action listener: _resource_record_pre_action 06:26:24 INFO - Running main action method: download_and_extract 06:26:24 INFO - mkdir: /builds/slave/test/build/tests 06:26:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:26:24 INFO - trying https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/target.test_packages.json 06:26:24 INFO - Downloading https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 06:26:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 06:26:25 INFO - Downloaded 989 bytes. 06:26:25 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 06:26:25 INFO - Using the following test package requirements: 06:26:25 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 06:26:25 INFO - u'common': [u'target.common.tests.zip'], 06:26:25 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 06:26:25 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 06:26:25 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 06:26:25 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 06:26:25 INFO - u'mozbase': [u'target.common.tests.zip'], 06:26:25 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 06:26:25 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 06:26:25 INFO - u'web-platform': [u'target.common.tests.zip', 06:26:25 INFO - u'target.web-platform.tests.tar.gz'], 06:26:25 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 06:26:25 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 06:26:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/target.common.tests.zip 06:26:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:26:25 INFO - Fetch https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/target.common.tests.zip into memory 06:26:26 INFO - Content-Length response header: 72769302 06:26:26 INFO - Bytes received: 72769302 06:26:37 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 06:26:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/target.common.tests.zip 06:26:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 06:26:37 INFO - Fetch https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/target.common.tests.zip into memory 06:26:38 INFO - Content-Length response header: 72769302 06:26:38 INFO - Bytes received: 72769302 06:26:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/target.talos.tests.zip 06:26:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 06:26:53 INFO - Fetch https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/target.talos.tests.zip into memory 06:26:53 INFO - Content-Length response header: 14498866 06:26:53 INFO - Bytes received: 14498866 06:26:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:26:54 INFO - trying https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/target.tar.bz2 06:26:54 INFO - Downloading https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 06:26:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 06:26:55 INFO - Downloaded 62061380 bytes. 06:26:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/target.tar.bz2 06:26:55 INFO - mkdir: /builds/slave/test/properties 06:26:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:26:55 INFO - Writing to file /builds/slave/test/properties/build_url 06:26:55 INFO - Contents: 06:26:55 INFO - build_url:https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/target.tar.bz2 06:26:55 INFO - Running post-action listener: _resource_record_post_action 06:26:55 INFO - Running post-action listener: set_extra_try_arguments 06:26:55 INFO - [mozharness: 2017-07-25 13:26:55.285194Z] Finished download-and-extract step (success) 06:26:55 INFO - [mozharness: 2017-07-25 13:26:55.285291Z] Running populate-webroot step. 06:26:55 INFO - Running pre-action listener: _resource_record_pre_action 06:26:55 INFO - Running main action method: populate_webroot 06:26:55 INFO - {'suites': {'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:26:55 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:26:55 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 06:26:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:26:55 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 06:26:55 INFO - 'tests': ['damp', 'tps']}, 06:26:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:26:55 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 06:26:55 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 06:26:55 INFO - 'tests': ['ts_paint_webext', 'tp5o_webext']}, 06:26:55 INFO - 'other-e10s': {'tests': ['a11yr', 06:26:55 INFO - 'ts_paint', 06:26:55 INFO - 'tpaint', 06:26:55 INFO - 'sessionrestore', 06:26:55 INFO - 'sessionrestore_many_windows', 06:26:55 INFO - 'sessionrestore_no_auto_restore', 06:26:55 INFO - 'tabpaint']}, 06:26:55 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic']}, 06:26:55 INFO - 'perf-reftest-singletons-e10s': {'tests': ['bloom_basic_singleton']}, 06:26:55 INFO - 'quantum-pageload-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:26:55 INFO - 'talos_options': ['--mitmproxy', 06:26:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:26:55 INFO - '--firstNonBlankPaint'], 06:26:55 INFO - 'tests': ['quantum_pageload_google', 06:26:55 INFO - 'quantum_pageload_youtube', 06:26:55 INFO - 'quantum_pageload_amazon', 06:26:55 INFO - 'quantum_pageload_facebook']}, 06:26:55 INFO - 'quantum-pageload-stylo-e10s': {'mitmproxy_recording_set': 'mitmproxy-recording-set-win10.zip', 06:26:55 INFO - 'talos_options': ['--stylo', 06:26:55 INFO - '--mitmproxy', 06:26:55 INFO - 'mitmproxy-recording-google.mp mitmproxy-recording-youtube.mp mitmproxy-recording-amazon.mp mitmproxy-recording-facebook.mp', 06:26:55 INFO - '--firstNonBlankPaint'], 06:26:55 INFO - 'tests': ['quantum_pageload_google', 06:26:55 INFO - 'quantum_pageload_youtube', 06:26:55 INFO - 'quantum_pageload_amazon', 06:26:55 INFO - 'quantum_pageload_facebook']}, 06:26:55 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:26:55 INFO - 'tsvgr_opacity', 06:26:55 INFO - 'tart', 06:26:55 INFO - 'tscrollx', 06:26:55 INFO - 'cart', 06:26:55 INFO - 'tsvg_static']}, 06:26:55 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 06:26:55 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 06:26:55 INFO - 'talos_options': ['--xperf_path', 06:26:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:26:55 INFO - 'tests': ['tp5n']}}} 06:26:55 INFO - Running post-action listener: _resource_record_post_action 06:26:55 INFO - [mozharness: 2017-07-25 13:26:55.292621Z] Finished populate-webroot step (success) 06:26:55 INFO - [mozharness: 2017-07-25 13:26:55.292711Z] Running create-virtualenv step. 06:26:55 INFO - Running pre-action listener: _resource_record_pre_action 06:26:55 INFO - Running main action method: create_virtualenv 06:26:55 INFO - Creating virtualenv /builds/slave/test/build/venv 06:26:55 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:26:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:26:55 INFO - Using partial env: {'VIRTUALENV_NO_DOWNLOAD': '1'} 06:26:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:26:55 INFO - Using real prefix '/usr' 06:26:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:26:55 INFO - Installing distribute.............................................................................................................................................................................................done. 06:26:57 INFO - Installing pip.................done. 06:26:57 INFO - Return code: 0 06:26:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:26:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:26:58 INFO - Reading from file tmpfile_stdout 06:26:58 INFO - Output received: 06:26:58 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 06:26:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:58 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 0xa361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda2eb0>, '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 0xda3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda4240>, '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': '3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:26:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 06:26:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 06:26:58 INFO - Using env: {'DISPLAY': ':0', 06:26:58 INFO - 'HOME': '/home/cltbld', 06:26:58 INFO - 'LANG': 'en_US.UTF-8', 06:26:58 INFO - 'LANGUAGE': 'en_US:en', 06:26:58 INFO - 'LOGNAME': 'cltbld', 06:26:58 INFO - 'MAIL': '/var/mail/cltbld', 06:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:58 INFO - 'MOZ_NO_REMOTE': '1', 06:26:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:26:58 INFO - 'NO_EM_RESTART': '1', 06:26:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:26:58 INFO - 'PWD': '/builds/slave/test', 06:26:58 INFO - 'SHELL': '/bin/bash', 06:26:58 INFO - 'SHLVL': '1', 06:26:58 INFO - 'TERM': 'linux', 06:26:58 INFO - 'TMOUT': '86400', 06:26:58 INFO - 'USER': 'cltbld', 06:26:58 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427', 06:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:58 INFO - '_': '/tools/buildbot/bin/python'} 06:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 06:26:58 INFO - Cleaning up... 06:26:58 INFO - Return code: 0 06:26:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:26:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:26:58 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 0xa361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda2eb0>, '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 0xda3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda4240>, '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': '3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:26:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 06:26:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 06:26:58 INFO - Using env: {'DISPLAY': ':0', 06:26:58 INFO - 'HOME': '/home/cltbld', 06:26:58 INFO - 'LANG': 'en_US.UTF-8', 06:26:58 INFO - 'LANGUAGE': 'en_US:en', 06:26:58 INFO - 'LOGNAME': 'cltbld', 06:26:58 INFO - 'MAIL': '/var/mail/cltbld', 06:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:26:58 INFO - 'MOZ_NO_REMOTE': '1', 06:26:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:26:58 INFO - 'NO_EM_RESTART': '1', 06:26:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:26:58 INFO - 'PWD': '/builds/slave/test', 06:26:58 INFO - 'SHELL': '/bin/bash', 06:26:58 INFO - 'SHLVL': '1', 06:26:58 INFO - 'TERM': 'linux', 06:26:58 INFO - 'TMOUT': '86400', 06:26:58 INFO - 'USER': 'cltbld', 06:26:58 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427', 06:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:26:58 INFO - '_': '/tools/buildbot/bin/python'} 06:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:26:58 INFO - Downloading/unpacking psutil>=3.1.1 06:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:26:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:26:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:26:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:26:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:26:59 INFO - Installing collected packages: psutil 06:26:59 INFO - Running setup.py install for psutil 06:26:59 INFO - building 'psutil._psutil_linux' extension 06:26:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 06:26:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:26:59 INFO - building 'psutil._psutil_posix' extension 06:26:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 06:27:00 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 06:27:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:27:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:27:00 INFO - Successfully installed psutil 06:27:00 INFO - Cleaning up... 06:27:00 INFO - Return code: 0 06:27:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:27:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:00 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 0xa361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda2eb0>, '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 0xda3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda4240>, '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': '3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:27:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 06:27:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 06:27:00 INFO - Using env: {'DISPLAY': ':0', 06:27:00 INFO - 'HOME': '/home/cltbld', 06:27:00 INFO - 'LANG': 'en_US.UTF-8', 06:27:00 INFO - 'LANGUAGE': 'en_US:en', 06:27:00 INFO - 'LOGNAME': 'cltbld', 06:27:00 INFO - 'MAIL': '/var/mail/cltbld', 06:27:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:00 INFO - 'MOZ_NO_REMOTE': '1', 06:27:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:00 INFO - 'NO_EM_RESTART': '1', 06:27:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:00 INFO - 'PWD': '/builds/slave/test', 06:27:00 INFO - 'SHELL': '/bin/bash', 06:27:00 INFO - 'SHLVL': '1', 06:27:00 INFO - 'TERM': 'linux', 06:27:00 INFO - 'TMOUT': '86400', 06:27:00 INFO - 'USER': 'cltbld', 06:27:00 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427', 06:27:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:00 INFO - '_': '/tools/buildbot/bin/python'} 06:27:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:27:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:27:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:27:01 INFO - Installing collected packages: mozsystemmonitor 06:27:01 INFO - Running setup.py install for mozsystemmonitor 06:27:01 INFO - Successfully installed mozsystemmonitor 06:27:01 INFO - Cleaning up... 06:27:01 INFO - Return code: 0 06:27:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:27: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')]} 06:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27: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')]} 06:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:01 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 0xa361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda2eb0>, '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 0xda3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda4240>, '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': '3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:27:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 06:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 06:27:01 INFO - Using env: {'DISPLAY': ':0', 06:27:01 INFO - 'HOME': '/home/cltbld', 06:27:01 INFO - 'LANG': 'en_US.UTF-8', 06:27:01 INFO - 'LANGUAGE': 'en_US:en', 06:27:01 INFO - 'LOGNAME': 'cltbld', 06:27:01 INFO - 'MAIL': '/var/mail/cltbld', 06:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:01 INFO - 'MOZ_NO_REMOTE': '1', 06:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:01 INFO - 'NO_EM_RESTART': '1', 06:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:01 INFO - 'PWD': '/builds/slave/test', 06:27:01 INFO - 'SHELL': '/bin/bash', 06:27:01 INFO - 'SHLVL': '1', 06:27:01 INFO - 'TERM': 'linux', 06:27:01 INFO - 'TMOUT': '86400', 06:27:01 INFO - 'USER': 'cltbld', 06:27:01 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427', 06:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:01 INFO - '_': '/tools/buildbot/bin/python'} 06:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:01 INFO - Downloading/unpacking jsonschema==2.5.1 06:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:27:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:03 INFO - Downloading functools32-3.2.3-2.tar.gz 06:27:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:27:03 INFO - warning: no files found matching '*.txt' 06:27:03 INFO - no previously-included directories found matching 'build' 06:27:03 INFO - no previously-included directories found matching 'dist' 06:27:03 INFO - no previously-included directories found matching '.git*' 06:27:03 INFO - Installing collected packages: jsonschema, functools32 06:27:03 INFO - Running setup.py install for functools32 06:27:03 INFO - warning: no files found matching '*.txt' 06:27:03 INFO - no previously-included directories found matching 'build' 06:27:03 INFO - no previously-included directories found matching 'dist' 06:27:03 INFO - no previously-included directories found matching '.git*' 06:27:03 INFO - Successfully installed jsonschema functools32 06:27:03 INFO - Cleaning up... 06:27:03 INFO - Return code: 0 06:27:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xa361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda2eb0>, '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 0xda3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda4240>, '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': '3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:27:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 06:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 06:27:03 INFO - Using env: {'DISPLAY': ':0', 06:27:03 INFO - 'HOME': '/home/cltbld', 06:27:03 INFO - 'LANG': 'en_US.UTF-8', 06:27:03 INFO - 'LANGUAGE': 'en_US:en', 06:27:03 INFO - 'LOGNAME': 'cltbld', 06:27:03 INFO - 'MAIL': '/var/mail/cltbld', 06:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:03 INFO - 'MOZ_NO_REMOTE': '1', 06:27:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:03 INFO - 'NO_EM_RESTART': '1', 06:27:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:03 INFO - 'PWD': '/builds/slave/test', 06:27:03 INFO - 'SHELL': '/bin/bash', 06:27:03 INFO - 'SHLVL': '1', 06:27:03 INFO - 'TERM': 'linux', 06:27:03 INFO - 'TMOUT': '86400', 06:27:03 INFO - 'USER': 'cltbld', 06:27:03 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427', 06:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:03 INFO - '_': '/tools/buildbot/bin/python'} 06:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:27:03 INFO - Cleaning up... 06:27:03 INFO - Return code: 0 06:27:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xa361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda2eb0>, '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 0xda3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda4240>, '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': '3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:27:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:27:03 INFO - Using env: {'DISPLAY': ':0', 06:27:03 INFO - 'HOME': '/home/cltbld', 06:27:03 INFO - 'LANG': 'en_US.UTF-8', 06:27:03 INFO - 'LANGUAGE': 'en_US:en', 06:27:03 INFO - 'LOGNAME': 'cltbld', 06:27:03 INFO - 'MAIL': '/var/mail/cltbld', 06:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:03 INFO - 'MOZ_NO_REMOTE': '1', 06:27:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:03 INFO - 'NO_EM_RESTART': '1', 06:27:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:03 INFO - 'PWD': '/builds/slave/test', 06:27:03 INFO - 'SHELL': '/bin/bash', 06:27:03 INFO - 'SHLVL': '1', 06:27:03 INFO - 'TERM': 'linux', 06:27:03 INFO - 'TMOUT': '86400', 06:27:03 INFO - 'USER': 'cltbld', 06:27:03 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427', 06:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:03 INFO - '_': '/tools/buildbot/bin/python'} 06:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:03 INFO - Downloading/unpacking blobuploader==1.2.4 06:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:04 INFO - Downloading blobuploader-1.2.4.tar.gz 06:27:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:27:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:27:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:05 INFO - Downloading docopt-0.6.1.tar.gz 06:27:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:27:05 INFO - Installing collected packages: blobuploader, requests, docopt 06:27:05 INFO - Running setup.py install for blobuploader 06:27:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:27:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:27:05 INFO - Running setup.py install for requests 06:27:06 INFO - Running setup.py install for docopt 06:27:06 INFO - Successfully installed blobuploader requests docopt 06:27:06 INFO - Cleaning up... 06:27:06 INFO - Return code: 0 06:27:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:27:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:06 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 0xa361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda2eb0>, '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 0xda3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda4240>, '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': '3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:27:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:27:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:27:06 INFO - Using env: {'DISPLAY': ':0', 06:27:06 INFO - 'HOME': '/home/cltbld', 06:27:06 INFO - 'LANG': 'en_US.UTF-8', 06:27:06 INFO - 'LANGUAGE': 'en_US:en', 06:27:06 INFO - 'LOGNAME': 'cltbld', 06:27:06 INFO - 'MAIL': '/var/mail/cltbld', 06:27:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:06 INFO - 'MOZ_NO_REMOTE': '1', 06:27:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:06 INFO - 'NO_EM_RESTART': '1', 06:27:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:06 INFO - 'PWD': '/builds/slave/test', 06:27:06 INFO - 'SHELL': '/bin/bash', 06:27:06 INFO - 'SHLVL': '1', 06:27:06 INFO - 'TERM': 'linux', 06:27:06 INFO - 'TMOUT': '86400', 06:27:06 INFO - 'USER': 'cltbld', 06:27:06 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427', 06:27:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:06 INFO - '_': '/tools/buildbot/bin/python'} 06:27:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:27:06 INFO - Running setup.py (path:/tmp/pip-90znQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:27:06 INFO - Running setup.py (path:/tmp/pip-Yek4uO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:27:06 INFO - Running setup.py (path:/tmp/pip-ldJCrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:27:06 INFO - Running setup.py (path:/tmp/pip-0f4ppf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:27:06 INFO - Running setup.py (path:/tmp/pip-Lb4Luw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:27:06 INFO - Running setup.py (path:/tmp/pip-FQKMLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:27:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:27:06 INFO - Running setup.py (path:/tmp/pip-8xwCvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:27:07 INFO - Running setup.py (path:/tmp/pip-x6iADb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:27:07 INFO - Running setup.py (path:/tmp/pip-r3UUf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:27:07 INFO - Running setup.py (path:/tmp/pip-28N12K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:27:07 INFO - Running setup.py (path:/tmp/pip-8HgPXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:27:07 INFO - Running setup.py (path:/tmp/pip-gSWBdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:27:07 INFO - Running setup.py (path:/tmp/pip-OUg2Rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:27:07 INFO - Running setup.py (path:/tmp/pip-JeDXhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:07 INFO - Running setup.py (path:/tmp/pip-z24EFB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:27:07 INFO - Running setup.py (path:/tmp/pip-VONVDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:27:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:27:07 INFO - Running setup.py (path:/tmp/pip-lC9FS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:27:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:27:07 INFO - Running setup.py install for manifestparser 06:27:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:27:07 INFO - Running setup.py install for mozcrash 06:27:07 INFO - Running setup.py install for mozdebug 06:27:08 INFO - Running setup.py install for mozdevice 06:27:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:27:08 INFO - Running setup.py install for mozfile 06:27:08 INFO - Running setup.py install for mozhttpd 06:27:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:27:08 INFO - Running setup.py install for mozinfo 06:27:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:27:08 INFO - Running setup.py install for mozInstall 06:27:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:27:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:27:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:27:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:27:08 INFO - Running setup.py install for mozleak 06:27:08 INFO - Running setup.py install for mozlog 06:27:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:27:08 INFO - Running setup.py install for moznetwork 06:27:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:27:08 INFO - Running setup.py install for mozprocess 06:27:08 INFO - Running setup.py install for mozprofile 06:27:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:27:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:27:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:27:09 INFO - Running setup.py install for mozrunner 06:27:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:27:09 INFO - Running setup.py install for mozscreenshot 06:27:09 INFO - Running setup.py install for moztest 06:27:09 INFO - Running setup.py install for mozversion 06:27:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:27:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:27:09 INFO - Cleaning up... 06:27:09 INFO - Return code: 0 06:27:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:27:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:27:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:09 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 0xa361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda2eb0>, '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 0xda3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda4240>, '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': '3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:27:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 06:27:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:27:09 INFO - Using env: {'DISPLAY': ':0', 06:27:09 INFO - 'HOME': '/home/cltbld', 06:27:09 INFO - 'LANG': 'en_US.UTF-8', 06:27:09 INFO - 'LANGUAGE': 'en_US:en', 06:27:09 INFO - 'LOGNAME': 'cltbld', 06:27:09 INFO - 'MAIL': '/var/mail/cltbld', 06:27:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:09 INFO - 'MOZ_NO_REMOTE': '1', 06:27:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:09 INFO - 'NO_EM_RESTART': '1', 06:27:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:09 INFO - 'PWD': '/builds/slave/test', 06:27:09 INFO - 'SHELL': '/bin/bash', 06:27:09 INFO - 'SHLVL': '1', 06:27:09 INFO - 'TERM': 'linux', 06:27:09 INFO - 'TMOUT': '86400', 06:27:09 INFO - 'USER': 'cltbld', 06:27:09 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427', 06:27:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:09 INFO - '_': '/tools/buildbot/bin/python'} 06:27:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:27:09 INFO - Running setup.py (path:/tmp/pip-jxbQuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:27:09 INFO - Running setup.py (path:/tmp/pip-qBCs3A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:27:09 INFO - Running setup.py (path:/tmp/pip-Nb8fte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:27:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:27:09 INFO - Running setup.py (path:/tmp/pip-V1JMq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.51 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:27:10 INFO - Running setup.py (path:/tmp/pip-m6Hjm6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:27:10 INFO - Running setup.py (path:/tmp/pip-hZJ9lE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:27:10 INFO - Running setup.py (path:/tmp/pip-DeMIrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:27:10 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)) 06:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:27:10 INFO - Running setup.py (path:/tmp/pip-MfQTr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:27:10 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)) 06:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:27:10 INFO - Running setup.py (path:/tmp/pip-PScXP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:27:10 INFO - Running setup.py (path:/tmp/pip-vFVs5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.5 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:27:10 INFO - Running setup.py (path:/tmp/pip-X2itly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:27:10 INFO - Running setup.py (path:/tmp/pip-ozDjve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:27:10 INFO - Running setup.py (path:/tmp/pip-p7InLC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:27:10 INFO - Running setup.py (path:/tmp/pip-4iHIk9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:10 INFO - Running setup.py (path:/tmp/pip-wMkt9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:27:10 INFO - Running setup.py (path:/tmp/pip-bYK5FB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:27:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:27:10 INFO - Running setup.py (path:/tmp/pip-lpB1rD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:27:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.51->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:27:10 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)) 06:27:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.5->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:12 INFO - Downloading blessings-1.6.tar.gz 06:27:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:27:12 INFO - Installing collected packages: blessings 06:27:12 INFO - Running setup.py install for blessings 06:27:12 INFO - Successfully installed blessings 06:27:12 INFO - Cleaning up... 06:27:12 INFO - Return code: 0 06:27:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:27:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:27:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:27:12 INFO - Reading from file tmpfile_stdout 06:27:12 INFO - Current package versions: 06:27:12 INFO - argparse == 1.2.1 06:27:12 INFO - blessings == 1.6 06:27:12 INFO - blobuploader == 1.2.4 06:27:12 INFO - docopt == 0.6.1 06:27:12 INFO - functools32 == 3.2.3-2 06:27:12 INFO - jsonschema == 2.5.1 06:27:12 INFO - manifestparser == 1.1 06:27:12 INFO - mozInstall == 1.13 06:27:12 INFO - mozcrash == 1.0 06:27:12 INFO - mozdebug == 0.1 06:27:12 INFO - mozdevice == 0.51 06:27:12 INFO - mozfile == 1.2 06:27:12 INFO - mozhttpd == 0.7 06:27:12 INFO - mozinfo == 0.10 06:27:12 INFO - mozleak == 0.1 06:27:12 INFO - mozlog == 3.5 06:27:12 INFO - moznetwork == 0.27 06:27:12 INFO - mozprocess == 0.25 06:27:12 INFO - mozprofile == 0.28 06:27:12 INFO - mozrunner == 6.13 06:27:12 INFO - mozscreenshot == 0.1 06:27:12 INFO - mozsystemmonitor == 0.3 06:27:12 INFO - moztest == 0.8 06:27:12 INFO - mozversion == 1.4 06:27:12 INFO - psutil == 3.1.1 06:27:12 INFO - requests == 1.2.3 06:27:12 INFO - wsgiref == 0.1.2 06:27:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:27:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:12 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 0xa361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda2eb0>, '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 0xda3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda4240>, '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': '3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:27:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 06:27:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 06:27:12 INFO - Using env: {'DISPLAY': ':0', 06:27:12 INFO - 'HOME': '/home/cltbld', 06:27:12 INFO - 'LANG': 'en_US.UTF-8', 06:27:12 INFO - 'LANGUAGE': 'en_US:en', 06:27:12 INFO - 'LOGNAME': 'cltbld', 06:27:12 INFO - 'MAIL': '/var/mail/cltbld', 06:27:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:12 INFO - 'MOZ_NO_REMOTE': '1', 06:27:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:12 INFO - 'NO_EM_RESTART': '1', 06:27:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:12 INFO - 'PWD': '/builds/slave/test', 06:27:12 INFO - 'SHELL': '/bin/bash', 06:27:12 INFO - 'SHLVL': '1', 06:27:12 INFO - 'TERM': 'linux', 06:27:12 INFO - 'TMOUT': '86400', 06:27:12 INFO - 'USER': 'cltbld', 06:27:12 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427', 06:27:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:12 INFO - '_': '/tools/buildbot/bin/python'} 06:27:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:27:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:27:12 INFO - Downloading/unpacking marionette-driver>=1.4.0 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:27: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 06:27: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 06:27: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 06:27: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 06:27:13 INFO - Downloading marionette_driver-1.4.0.tar.gz 06:27:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/marionette-driver/setup.py) egg_info for package marionette-driver 06:27:13 INFO - Downloading/unpacking simplejson>=2.1.1 (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 11)) 06:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:27:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:27:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/simplejson/setup.py) egg_info for package simplejson 06:27:14 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:27:14 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:27:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner>=6.9 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:27:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice>=0.37 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozrunner>=6.9->marionette-driver>=1.4.0->-r /builds/slave/test/build/tests/talos/requirements.txt (line 10)) 06:27:14 INFO - Installing collected packages: marionette-driver, simplejson 06:27:14 INFO - Running setup.py install for marionette-driver 06:27:14 INFO - Running setup.py install for simplejson 06:27:14 INFO - building 'simplejson._speedups' extension 06:27:14 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c simplejson/_speedups.c -o build/temp.linux-x86_64-2.7/simplejson/_speedups.o 06:27:15 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/simplejson/_speedups.o -o build/lib.linux-x86_64-2.7/simplejson/_speedups.so 06:27:15 INFO - Successfully installed marionette-driver simplejson 06:27:15 INFO - Cleaning up... 06:27:15 INFO - Return code: 0 06:27:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:27:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:27:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:27:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:27:15 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 0xa361f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc02a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xda5d10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xda2eb0>, '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 0xda3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda4240>, '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': '3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 06:27:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:27:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:27:15 INFO - Using env: {'DISPLAY': ':0', 06:27:15 INFO - 'HOME': '/home/cltbld', 06:27:15 INFO - 'LANG': 'en_US.UTF-8', 06:27:15 INFO - 'LANGUAGE': 'en_US:en', 06:27:15 INFO - 'LOGNAME': 'cltbld', 06:27:15 INFO - 'MAIL': '/var/mail/cltbld', 06:27:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:15 INFO - 'MOZ_NO_REMOTE': '1', 06:27:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:15 INFO - 'NO_EM_RESTART': '1', 06:27:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:15 INFO - 'PWD': '/builds/slave/test', 06:27:15 INFO - 'SHELL': '/bin/bash', 06:27:15 INFO - 'SHLVL': '1', 06:27:15 INFO - 'TERM': 'linux', 06:27:15 INFO - 'TMOUT': '86400', 06:27:15 INFO - 'USER': 'cltbld', 06:27:15 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427', 06:27:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:15 INFO - '_': '/tools/buildbot/bin/python'} 06:27:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:27:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:27:15 INFO - Cleaning up... 06:27:15 INFO - Return code: 0 06:27:15 INFO - Running post-action listener: _resource_record_post_action 06:27:15 INFO - Running post-action listener: _start_resource_monitoring 06:27:15 INFO - Starting resource monitoring. 06:27:15 INFO - [mozharness: 2017-07-25 13:27:15.611061Z] Finished create-virtualenv step (success) 06:27:15 INFO - [mozharness: 2017-07-25 13:27:15.611530Z] Running install step. 06:27:15 INFO - Running pre-action listener: _resource_record_pre_action 06:27:15 INFO - Running main action method: install 06:27:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:27:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:27:15 INFO - Reading from file tmpfile_stdout 06:27:15 INFO - Detecting whether we're running mozinstall >=1.0... 06:27:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:27:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:27:15 INFO - Reading from file tmpfile_stdout 06:27:15 INFO - Output received: 06:27:15 INFO - Usage: mozinstall [options] installer 06:27:15 INFO - Options: 06:27:15 INFO - -h, --help show this help message and exit 06:27:15 INFO - -d DEST, --destination=DEST 06:27:15 INFO - Directory to install application into. [default: 06:27:15 INFO - "/builds/slave/test"] 06:27:15 INFO - --app=APP Application being installed. [default: firefox] 06:27:15 INFO - mkdir: /builds/slave/test/build/application 06:27:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:27:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 06:27:33 INFO - Reading from file tmpfile_stdout 06:27:33 INFO - Output received: 06:27:33 INFO - /builds/slave/test/build/application/firefox/firefox 06:27:33 INFO - Running post-action listener: _resource_record_post_action 06:27:33 INFO - [mozharness: 2017-07-25 13:27:33.932734Z] Finished install step (success) 06:27:33 INFO - [mozharness: 2017-07-25 13:27:33.932991Z] Running setup-mitmproxy step. 06:27:33 INFO - Running pre-action listener: _resource_record_pre_action 06:27:33 INFO - Running main action method: setup_mitmproxy 06:27:33 INFO - Skipping: mitmproxy is not required 06:27:33 INFO - Running post-action listener: _resource_record_post_action 06:27:33 INFO - [mozharness: 2017-07-25 13:27:33.934236Z] Finished setup-mitmproxy step (success) 06:27:33 INFO - [mozharness: 2017-07-25 13:27:33.934458Z] Running run-tests step. 06:27:33 INFO - Running pre-action listener: _resource_record_pre_action 06:27:33 INFO - Running pre-action listener: _set_gcov_prefix 06:27:33 INFO - Running main action method: run_tests 06:27:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:27:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:27:33 INFO - Python 2.7.3 06:27:33 INFO - Return code: 0 06:27:33 INFO - grabbing minidump binary from tooltool 06:27:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:27:33 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 0xda2eb0>, '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 0xda3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xda4240>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:27:33 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:27:33 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 06:27:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 06:27:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:27:34 INFO - Return code: 0 06:27:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:27:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:27:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:27:34 INFO - ENV: RUST_BACKTRACE is now 1 06:27:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:27:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:27:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Cedar --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:27:34 INFO - Using env: {'DISPLAY': ':0', 06:27:34 INFO - 'HOME': '/home/cltbld', 06:27:34 INFO - 'LANG': 'en_US.UTF-8', 06:27:34 INFO - 'LANGUAGE': 'en_US:en', 06:27:34 INFO - 'LOGNAME': 'cltbld', 06:27:34 INFO - 'MAIL': '/var/mail/cltbld', 06:27:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:27:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:27:34 INFO - 'MOZ_NO_REMOTE': '1', 06:27:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:27:34 INFO - 'NO_EM_RESTART': '1', 06:27:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:27:34 INFO - 'PWD': '/builds/slave/test', 06:27:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:27:34 INFO - 'RUST_BACKTRACE': '1', 06:27:34 INFO - 'SCRIPTSPATH': '/builds/slave/test/scripts', 06:27:34 INFO - 'SHELL': '/bin/bash', 06:27:34 INFO - 'SHLVL': '1', 06:27:34 INFO - 'TERM': 'linux', 06:27:34 INFO - 'TMOUT': '86400', 06:27:34 INFO - 'USER': 'cltbld', 06:27:34 INFO - 'XDG_SESSION_COOKIE': '3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427', 06:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:27:34 INFO - '_': '/tools/buildbot/bin/python'} 06:27:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Cedar', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:27:34 INFO - mozversion application_buildid: 20170725124118 06:27:34 INFO - mozversion application_changeset: 8c5ace71270c76e17b884c50e10cbf333d7c33a2 06:27:34 INFO - mozversion application_display_name: Nightly 06:27:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:27:34 INFO - mozversion application_name: Firefox 06:27:34 INFO - mozversion application_remotingname: firefox 06:27:34 INFO - mozversion application_repository: https://hg.mozilla.org/projects/cedar 06:27:34 INFO - mozversion application_vendor: Mozilla 06:27:34 INFO - mozversion application_version: 56.0a1 06:27:34 INFO - mozversion platform_buildid: 20170725124118 06:27:34 INFO - mozversion platform_changeset: 8c5ace71270c76e17b884c50e10cbf333d7c33a2 06:27:34 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/cedar 06:27:34 INFO - mozversion platform_version: 56.0a1 06:27:34 INFO - using testdate: 1500989254 06:27:34 INFO - actual date: 1500989254 06:27:34 INFO - starting webserver on 'localhost:51808' 06:27:34 INFO - SUITE-START | Running 2 tests 06:27:34 INFO - TEST-START | dromaeo_css 06:27:34 INFO - Initialising browser for dromaeo_css test... 06:27:34 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51808/getInfo.html -profile /tmp/tmpwSIrcl/profile 06:27:34 INFO - TEST-INFO | started process 14646 (/builds/slave/test/build/application/firefox/firefox http://localhost:51808/getInfo.html) 06:27:40 INFO - TEST-INFO | 14646: exit 0 06:27:40 INFO - Browser initialized. 06:27:40 INFO - Running cycle 1/1 for dromaeo_css test... 06:27:40 INFO - TEST-INFO | started process 14853 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwSIrcl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:27:41 INFO - PID 14853 | 06:27:41 INFO - PID 14853 | (/builds/slave/test/build/application/firefox/firefox:14902): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:27:41 INFO - PID 14853 | 06:27:51 INFO - PID 14853 | RSS: Main: 171810816 06:27:51 INFO - PID 14853 | 06:30:50 INFO - PID 14853 | Cycle 1(1): loaded http://localhost:51808/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51808/tests/dromaeo/cssquery-ext.html) 06:30:52 INFO - PID 14853 | RSS: Main: 173297664 06:30:52 INFO - PID 14853 | 06:33:54 INFO - PID 14853 | Cycle 1(1): loaded http://localhost:51808/tests/dromaeo/cssquery-ext.html (next: http://localhost:51808/tests/dromaeo/cssquery-jquery.html) 06:33:54 INFO - PID 14853 | RSS: Main: 170848256 06:33:54 INFO - PID 14853 | 06:36:56 INFO - PID 14853 | Cycle 1(1): loaded http://localhost:51808/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51808/tests/dromaeo/cssquery-mootools.html) 06:36:57 INFO - PID 14853 | RSS: Main: 172158976 06:36:57 INFO - PID 14853 | 06:39:59 INFO - PID 14853 | Cycle 1(1): loaded http://localhost:51808/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51808/tests/dromaeo/cssquery-prototype.html) 06:39:59 INFO - PID 14853 | RSS: Main: 171945984 06:39:59 INFO - PID 14853 | 06:43:03 INFO - PID 14853 | Cycle 1(1): loaded http://localhost:51808/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51808/tests/dromaeo/cssquery-yui.html) 06:43:04 INFO - PID 14853 | RSS: Main: 173699072 06:43:04 INFO - PID 14853 | 06:46:05 INFO - PID 14853 | Cycle 1(1): loaded http://localhost:51808/tests/dromaeo/cssquery-yui.html (next: http://localhost:51808/tests/dromaeo/cssquery-dojo.html) 06:46:06 INFO - PID 14853 | RSS: Main: 175788032 06:46:06 INFO - PID 14853 | 06:46:06 INFO - PID 14853 | __start_tp_report 06:46:06 INFO - PID 14853 | _x_x_mozilla_page_load 06:46:06 INFO - PID 14853 | _x_x_mozilla_page_load_details 06:46:06 INFO - PID 14853 | |i|pagename|runs| 06:46:06 INFO - PID 14853 | |0;dojo.html;3093.242155671861;3160.27313717845;3165.699258570435;3193.712565869071;3203.8398080096003;6081.331053584102;6152.138700581917;6156.261248650163;6251.12484252205;6335.778247761329;6091.695415229243;6133.110698948661;6212.471939885104;6221;6268.780592679257;5575.330960284771;5651.802186923458;5719.599628026019;5727.026405511052;5769.7692092316365;5588.329400471929;5781.855453613652;5801.82594522165;5801.883962320751;5814.069748840187;5687.118496633028;5708.914366284509;5785.942140578624;5802.680852553129;5811.128330750379;5507.917381239285;5596.776128954837;5665.8583535411535;5709.77160913563;5773.480386765212;5628.81891490488;5715.428457154293;5718.914216286759;5718.942810571924;5728;6148.78479253224;6156.630602163839;6243.687815609247;6268.091126786636;6279.466245369149;6504.861649211416;6535.869282614369;6603.471722262208;6621.337866213388;6711.463082953352;6757.966210168966;6764.526483146182;6805.149356330458;6815.114035175445;6821.147356580427;6136.478399336062;6172.29018662855;6192.845178870564;6240.438360547572;6297.118403423525;6638.834029149213;6742.056112144303;6842.418394436529;6978.162620485473;6982;6483.481321494363;6490.8052758417325;6494.740210391626;6503.089567460559;6512.283648798629;6594.307597702268;6673.998900165014;6692.096566963398;6693;6701.29636388182;6549.770758023446;6550.639714815636;6590.703418346186;6673.966630166915;6677.565958212701;6461.450776683941;6561.376669216417;6571.178602674666;6653.700583473756;6700.128983232149;5314.840554783363;5322.92015619766;5326.760295786699;5328.813491527778;5338.759755810997;4582.1293954148605;4604.746738929391;4633.49031606523;4640.907181856344;4673.742944138037;5677.545796336283;5739.995500787346;5757.510611597977;5763.250777398911;5780.479756821822;6540.9345906541275;6626.271110177877;6642.1033160523675;6685;6703.93296067033;5740.942590574125;5756.42435756421;5759.596828221985;5763.077907534775;5767.077267637158;5835.387284335168;5842.415758424208;5854.414558544197;5859.267591551056;5859.53123750099;6400.807975760735;6451;6475.190601174853;6475.417212450902;6487.2539657939;6662.76680316206;6674.466042716668;6699;6708.765193218214;6712.563683360566;6461.870762584816;6468.741250349934;6495;6497.927841906033;6546.639934803631;6558.868822623616;6567.671616419256;6645.6677166140535;6666;6675.198976122702;6601.636909969806;6707.228668702966;6708.83227919306;6731.394174524316;6817.488688348294;6398.71205795731;6406.423421892052;6431.903521447276;6438.90341644885;6439.356064393523;5523;6442.677866106582;6468.288488266381;6511.34886511364;6593.472522198117;6206.658633775005;6310.368963103653;6319.46284565817;6429.8714025720155;6498;6371;6434.099226108442;6448.097266382804;6480.060391243149;6480.70836812354;6221.626702397871;6225.408586184305;6226.346233645402;6228.22147231596;6228.252609686867 06:46:06 INFO - PID 14853 | |1;ext.html;777.4518964130289;855.170484629909;882.7087061269782;883.6597909804725;1137.5677242647794;30719.84640076802;31318.060458186235;41178.38232426516;41775.58224417755;41776.582234177724;41316;41353.58646413535;41885.371719424234;41938.790306048424;42036.78981605088;7170.390516806077;7483.550986940773;7637.083549973983;7643.694252229904;7725;7485.700571977114;7495.400367970577;7574.166841647414;7583.241675832428;7584.65869035892;7569.886451703229;7626.161122276545;7627.084749830001;7630.694772209133;7632.427567932399;7527.39780817536;7538.472306938516;7576.621168941531;7584.43116766242;7601.619919004083;7437.479376443651;7468.701251949916;7527.924720752777;7549.5470271783315;7569.091708994956;37946.62053379459;38111.04722381935;38375.42436863449;38379.23241535181;38518.80740596279;3565.839537220805;3584.1039740064984;3603.873864414733;3613.7831730096277;3614.439761836893;30606.69393306083;30845.845770771226;31123.221919452193;31327.53008704871;31357.52963705546;4698.365720627706;4902.264660300948;4902.852914412573;4915.434725006634;4926.236433352836;196024.0198799011;196568;198160;198702;199375;48756.512434875905;48870.26694599584;49122.26316605254;49995.250071248236;50153.74923125361;51824.22263666048;51880.74059629753;51894;51908.74045629748;51951.74024129931;15989.040657560583;16392.508224753277;16400.425985090464;16666.58333541671;16748.330066797193;11960;11960.461779219782;12159.696007599881;12210.145289829805;13365.465381384636;14400.711985760436;14434.206118663575;14514.274286285643;14595.708085838223;14662.853371466148;5785.768569257267;5862.443067908542;5956.225690660186;6017.488513476404;6042.909356359658;993.2600212841479;996.9102780749768;1002.9147522460527;1033.3076838518211;1039.5841663334575;22673.319800406014;29096.272593184916;29541.26146846303;29545.409091818474;29939.700602993693;1091.2524920429373;1099.5931505343074;1110.6834552152598;1121.7924683933336;1123.309164863603;11877.653032887703;12493.875061249271;16079.196040197943;16121.193940302937;16305.836941630669;243173;244735;245593;245635;246151;56129.71935140298;56375.71812140913;56709.43290567124;56732.43267567354;57030.14454783181;1469.177260733971;1497.9400823966919;1500.647347873249;1501.8798496120285;1508.9773653395207;26925.596116057885;27820.44359112766;27855.303617409725;27991.300217494725;28312.85843570769;37579.81210093932;37821.05447363838;37863.81068094752;37873;37879.2424151521;204033;205248;205694;207584;207621;33468;37246.813765930994;37843;38012.23975520529;38141.4278785824;45694.543054569025;46086.769566151954;46247;46727.53272467232;46853.531464684915;33524.49713254254;34697;34756.30487390289;34879.65120348764;35488;33225.24320279383;33314.16714582155;33904.49143262902;34222.48666269958;34330;36585.268294634494;37096.443553347264;37104.628953711195;37145;37478.62521374752;32502.837485813365;32823.67176328206;33455.16362090967;33597.66402335945;34265.828670856485;24903.875480622482;25007.374815629755;25045.74954250507;25181;25646.230613081636 06:46:06 INFO - PID 14853 | |2;jquery.html;583.2942140010587;585.8154681275398;597.2683462758122;606.6178307666171;610.3073012131231;21636.56726865464;22355.55288894223;22458.775412245894;22460.32619021428;22492.200623950084;24226.27321180363;25279.494410111787;26483;26627.467450650976;26799;6513.80458586242;6652.06871038055;6655.367740064686;6663.133792606978;6677.399034086931;5915.260592425947;6483.675816209195;6518.902216466757;6563.409293163614;6601.075849381091;6421.967890160543;6470.611763294194;6470.644114573696;6471.514636402265;6485.935140648604;6447.161868957052;6463.773767918124;6475.32009139043;6482.513811464159;6487.545871788977;6001.5198784097165;6037.63774173551;6041.365656606037;6068.393160683941;6070.696465176768;27943.86028069867;28677.856610717023;28987.710122898923;29195.56206656902;30487.542686859713;1961.3037371733114;2013.0035632362074;2014.1540552967642;2014.909329080195;2015.4558269267363;18636.72044919327;19172.233110675556;19485.707714384294;19625.116869740898;19626.50933726654;2345.401922509749;2348.4011577047913;2406.1818981546185;2416.1301931304715;2433.2578563538113;134886;139556;139584;144215.27892360577;146498;14959.326830292663;15357.15535645528;15406.152661603495;15526.1460619667;15669.608259793597;23658.29025129249;23665.645015324782;23716.288511344686;23734.525309493714;23782.64326035111;10103.84844227337;10409.635662751767;10430.269881108401;10566.875065593182;10696.41169735672;9591.808163836684;9616.615335386507;9636.75908102303;9745.951270243604;9746.805063898682;8721.520316382534;9436.480993545421;9459.952700236454;9529.285303602257;9698.418094914186;2678.397360593851;2808.5927540506514;2845.6300680911763;2869.2826793301674;2873.1380585824168;908.8954770201511;930.7486978515898;938.1603464898877;974.2414941031507;979.2068424576116;19275.903620482088;19355.225790968205;20236.89881550583;23246.65130023051;24723.752762472504;1012.9696109116591;1030.835066389374;1045.9215558833118;1046.2205656785743;1072.9141668666489;11087.22389432732;11090.112790976864;11231.494582743797;11581.363025033705;11684.649460516199;504287;506813;521984;523267;523840;121296.39351803185;121784.39107804581;122124;123228.38385808193;123532;1248.9750204995848;1289.8903593194684;1306.9281189534668;1309.5547513845147;1313.40240190713;17037.40369087076;17673;18183.363582274556;18711.71932421042;18715.812841871953;55061;55122;55904;57366.7131664339;57583.42416575948;69503;69789.65105174441;70203.29796701968;70280;70517;12391.132620716824;12976.805347919977;14483.782743259071;14963.551093467213;15100.697986040437;18478.076096195404;22176.88911555432;23212;23692.05231790778;23818;18243.361482348053;18332.450026499228;18639.2544298232;18672.533186670444;18716.532086697942;16157.27292271827;16583;16907.746383804006;16957.830421695624;17488.03815790144;18411.72382414238;18667.813321866608;19007.619847603248;19034;19094;14655.92672036633;14702.191379473803;14714.117152970855;14738.926305368834;14878.479253226085;18213.726794097834;18229.45311640653;18420.63158736791;18726.71909921325;18808.623827523646 06:46:06 INFO - PID 14853 | |3;mootools.html;1328;1380.3788295267127;1408.1762169131064;1409.1826740490517;1409.6475881029742;13649.249291288976;13872.653183670413;14277.643058923531;14297.642558936019;14312.069715468488;14227.78658320126;14594.927025364885;14606.853931460682;14607.78088328676;14615.976881618291;2739.2877851758485;2791.8883244670187;2792.3577577157266;2792.6369571955615;2799.930001749952;2620.2008387441824;2801.8739156737997;2802.971970280302;2806.3685670724026;2807.719228077186;2695.218386667874;2707.810453268272;2724.141895302983;2734.1934129431766;2735.7948153888537;2541.224926397448;2560.3215147985798;2583.354161459635;2585.418280886795;2710.3088712378412;2603.5313643544346;2635.907743228997;2636.077372919482;2658.853763043032;2659.853708046057;13302.600921972356;13563.254021028839;13620.795688064687;13644.317784110755;13648.181109133484;7582.203868593829;7823.022122234721;7841.411894107965;7858.607069646495;7873.173316801711;4892.902141957176;5052.898942021139;5131.230315452674;5141.15170996785;5162.896742065138;1738.7218045112847;1765.2938824470186;1772.5923037701273;1828.5520047588293;1828.826261505155;21102.472438189016;21376.358709238593;21377;21514.247001355034;21542.461438464008;6416.647084410309;6417.229932408048;6439.549231553746;6559.344065593403;6599.142111525567;15720.92139539318;15726.528204153894;15738.9213053934;15744.763828542582;15747.842521574867;7329.083864516935;7460.888086678704;7495.66269517873;7502.812429689301;7529.774106776806;6736.124303840469;6838.487113466411;6940.930590694129;7051.964740176369;7056.92943070573;4931.90136197274;4970.378702662168;5015.3730783652045;5047.16721740916;5081.669691470042;1456.2936975566843;1457.7521821290406;1460.4523303761089;1468.860458256464;1494.6935878144955;848.2196379331031;858.7767180532982;867.1935100356603;881.259741816877;902.3638334973828;6711.395974362331;7006.369426751617;7065.258147894499;7128.108986376703;7133.215346311901;712.3161764705836;735.7829440315013;975.3611384543135;996.4220751963844;1009.9646512372178;4902.240152776325;4919.4834542373255;5012.699238045729;5380.3274590676165;5545.528630066489;19050.52373690669;19573.706394404096;19659;19814.216720495224;19958.50103747418;18890.905545472186;19347.903260483607;19589;19678.409647710592;19709.901450492944;9586.808263834684;9746.512674366253;9750.41497510166;9789.36369136018;9832.9016709832;7403.370713489198;7804.804879878048;7961.960190199244;8179.895714078523;8342.499450033018;16470.341186352412;16638.084905329837;16838.66322673564;16935.491935241964;17235.56911077183;16711.832881671027;17009.14954252307;17088.40190593323;17105.486835394957;17260.568485787455;11372.43137843121;11384.943075284571;11563.248388854698;11576.131790115944;11697.356645384585;12630.936845315715;13041;13050.477980881038;13051.543195988095;13058.542950996669;10382.636607718694;10568.89431105679;10648.467576620984;10753.569857205624;10805.675829725122;9869.457179855177;10338.12125969301;10407.739806504595;10422.947885260828;10540.947295263475;9561.091696288842;9720.125188733047;9728.17310528613;9734.513274336396;9757.316987810786;6808.931910681028;6929.514933954575;6979.511434199558;7094.432445404458;7110.715571377087;6237.157983672328;6578.934210657832;6651.866962660816;6806.081179040766;6870.45036397097 06:46:06 INFO - PID 14853 | |4;prototype.html;499.8004788507581;499.9550040496357;526.5971531778192;529.1005291005291;540.6269673924992;6194;6236.438720515147;6250.0624906263965;6296.559240853142;6318.778842740505;6077.939220607793;6134;6170.629762214259;6258.526517782629;6276.968615156918;5185.870353241162;5198.8700282493055;5230.372355317349;5265.973670131644;5276.894462110756;5140.228965655163;5217.713025783581;5218.7651555679895;5254.684718916858;5267.104592219332;5136.049830781318;5198.662086964335;5213.895722085556;5216.895662086775;5220.582353411718;5158.40678321994;5165.870853228681;5219.947800521984;5247.160454327328;5250.109960414248;4889.926651100236;4895.947371315185;4912.5578697917;4913.606911447111;4948.307236986825;6186.329690983454;6189.876202475925;6197.318294987548;6228.906566401508;6258.374162583751;5997.640141591475;6039.667818269993;6040;6061.393860613904;6106.72519736613;6652.268250492442;6654.500912431587;6665.666716664147;6681.966590167067;6714.395704386579;5344.893102137936;5348.197770334442;5376.838694839161;5381.892362152774;5408.35099788024;6973.442124630017;7012.509124361297;7036.859262814715;7057.36483716468;7089.078419805443;5472.425395333512;5481.506664400144;5507.779688812403;5511.22842802008;5562.888742225133;5599.440055994368;5603.971980140073;5608.523275521545;5611.691356975405;5650.773969041193;5900.20347253124;5939.22790037301;5944.286685597669;6026.427489388501;6052.6671033092725;6466.450351720063;6599.175103112111;6607.612401395664;6707.396334329934;6727.62998035103;1861.5346163459135;1885.7454243677203;1953.2187125150053;1971.960560788805;1973.1614064022733;1431.5633731711928;1444.826620805489;1463.5463006468028;1465.7508223602013;1484.8218213814412;5565.30433695788;5576.944230557642;5680.829575112753;5715.599908006399;5780.826575202751;6725.932740672629;6730.923052311607;6782.525223234326;6792.796216113525;6793;5610.719464026783;5684;5759.1649210865025;5763.827085187451;5768.567357448208;3623.8912832615065;3639.217568222845;3645.9453108203397;3649.927001459956;3673.2469843682516;6555.590548032196;6561.868762624721;6566.012464328719;6601.5378923475855;6672.466202703772;6931.202911665223;6940.479464040217;6980.359615490355;7000.579965202104;7011.368976792113;6534.575252608565;6580.243272023587;6591.43972762311;6614.834629134214;6646.933530664632;6769.323067693192;6781.491388146008;6783.966080169567;6807.183138023271;6809.5573787705625;6626.304238054935;6669.1330127083165;6683.732650693918;6696.1629796275465;6715.843553529833;6518.185226846645;6536.509761767981;6544.8363790905605;6568.6058836469965;6578.572392794453;5029.823956161663;5032.597392208688;5064.290999260033;5105.540501354896;5111.578484610859;6353.745850166127;6527.2167339919515;6563.818512667765;6746.730130794714;6864.897026544706;6427.967860160669;6521.706523206372;6523.510736694672;6571.178602674666;6595.340465953366;6462.676866156768;6467.741290348334;6539.280679125388;6540.280569137296;6622;6418.967905160444;6435.131257280207;6459.547831651739;6459.870802583828;6504.1869766279215;6449.806505804833;6468.803271394619;6477.352264773485;6517;6646.567973081735;6222.688865556795;6344.936550634619;6377.808665740035;6394.424501794861;6396.360363963567 06:46:06 INFO - PID 14853 | |5;yui.html;899.8155378147478;917.7338571814174;921.2767977137948;932.6782260120256;935.3312381647121;17964.10179491025;18819.905900470494;18839.811601883976;18886.811131888677;18944.431667049976;19585.118669659863;21236.4690882728;21346.25288114916;21369.145234190615;21395.037223324947;1009.8333774927147;1029.7168278723373;1032.076291718911;1032.2825636182856;1034.4672493665769;975.2393133355959;1029.2743615750878;1034.9016843399866;1047.0681093826502;1047.512906498478;1099.2140619457086;1099.3953325670889;1100.3342977498578;1100.6202860013282;1101.0200921180117;1087.4508373271487;1089.7221208591839;1090.4820210400076;1098.3080659184702;1098.653924013933;795.2484901767832;795.6181033104142;796.5698522797683;797.9720709775188;803.028335713787;19161;19296.71054934177;19517.121729522063;19534.31629892947;20017.59964800696;19975.80024199754;20052.598948020957;20543.486412839648;20588.5882282355;20590.485237869023;14650.340734666966;14870.330835112338;14929.626759330995;14950.70098598022;15146.848531514765;3590.856365745367;3609.873654422083;3610.6930910872607;3623.836927338276;3627;118495;120204.39897800455;123379.38310308481;126122;129496.35251823775;15542.611434714223;15574;15589;15912.204389780465;15918.283677234553;29538.852305738335;29869.701302987127;30273.24316892051;30303.848480757457;30362.089137325915;8077.798055048554;8577.828443431097;8677.913220867711;8693.521856297837;8766.38635295536;4174.707770456039;4252.383404406406;4254.149170165979;4268.914621707549;4271.188474189894;4651.930221046687;4892.975535122301;4958.652894297365;5111.846644600668;5947.464728174485;1119.4346854838254;1127.7067962329854;1136.9488373023235;1142.9028532574823;1144.2848219862585;671.563483735566;671.6977360187935;680.4454369688688;688.2944981394111;690.6270613868455;11487.597934072268;11972.178595467838;12296.323702196287;12524.937375313248;12550.435230414654;581.4882903045293;582.1297160744714;582.679526260555;584.1558947321165;591.4854076953078;5467.72661366938;5632.239647647597;5644.85887852807;5740.770369185186;5815.185873977646;98360.03279934361;99656.50171749094;101849;103347;105872;82192.58903705444;85200.14799851923;85347.57326213454;86141.99999999875;87304;76857;77098.61450692822;78317;79294.20705792983;80886;11586.420678966186;12068.517259309529;12247.57133500359;12326.445309960895;12427.316497592357;33953.15117122092;34758;35016.82491587526;36174.63825361818;37836.432453512665;45515.54484455245;47279;47362.52637473719;48031.27953080776;65479.67260163669;16731;18621.90689046546;18624.720629190302;19027.238910443426;19284.517887052934;20211.595768084262;20351.389458316273;21013.474663133544;21116.68324975096;21726.782732172476;18335.35826246075;18561.35035273759;19441.805581944565;19507.902460487607;19580.510487237934;19419;19474.415767526996;19524;19591.510212244237;19842.20631174737;17895.19471623806;18112.72830907564;18368.908155459136;18634.161462733937;18706.719399208752;13535.323233838466;13622.386992585556;13751.243681597609;14166.575002749521;14328.355224015153;13733.107348022346;14326.856731432552;14341.282935852956;14994;14994.775078373616 06:46:06 INFO - PID 14853 | __end_tp_report 06:46:06 INFO - PID 14853 | __start_cc_report 06:46:06 INFO - PID 14853 | _x_x_mozilla_cycle_collect,389 06:46:06 INFO - PID 14853 | __end_cc_report 06:46:06 INFO - PID 14853 | __startTimestamp1500990366064__endTimestamp 06:46:06 INFO - PID 14853 | 06:46:06 INFO - PID 14853 | ------- Summary: start ------- 06:46:06 INFO - PID 14853 | Number of tests: 6 06:46:06 INFO - PID 14853 | 06:46:06 INFO - PID 14853 | [#0] dojo.html Cycles:165 Average:6115.05 Median:6319.46 stddev:718.40 (11.4%) stddev-sans-first:680.37 06:46:06 INFO - PID 14853 | Values: 3093.2 3160.3 3165.7 3193.7 3203.8 6081.3 6152.1 6156.3 6251.1 6335.8 6091.7 6133.1 6212.5 6221.0 6268.8 5575.3 5651.8 5719.6 5727.0 5769.8 5588.3 5781.9 5801.8 5801.9 5814.1 5687.1 5708.9 5785.9 5802.7 5811.1 5507.9 5596.8 5665.9 5709.8 5773.5 5628.8 5715.4 5718.9 5718.9 5728.0 6148.8 6156.6 6243.7 6268.1 6279.5 6504.9 6535.9 6603.5 6621.3 6711.5 6758.0 6764.5 6805.1 6815.1 6821.1 6136.5 6172.3 6192.8 6240.4 6297.1 6638.8 6742.1 6842.4 6978.2 6982.0 6483.5 6490.8 6494.7 6503.1 6512.3 6594.3 6674.0 6692.1 6693.0 6701.3 6549.8 6550.6 6590.7 6674.0 6677.6 6461.5 6561.4 6571.2 6653.7 6700.1 5314.8 5322.9 5326.8 5328.8 5338.8 4582.1 4604.7 4633.5 4640.9 4673.7 5677.5 5740.0 5757.5 5763.3 5780.5 6540.9 6626.3 6642.1 6685.0 6703.9 5740.9 5756.4 5759.6 5763.1 5767.1 5835.4 5842.4 5854.4 5859.3 5859.5 6400.8 6451.0 6475.2 6475.4 6487.3 6662.8 6674.5 6699.0 6708.8 6712.6 6461.9 6468.7 6495.0 6497.9 6546.6 6558.9 6567.7 6645.7 6666.0 6675.2 6601.6 6707.2 6708.8 6731.4 6817.5 6398.7 6406.4 6431.9 6438.9 6439.4 5523.0 6442.7 6468.3 6511.3 6593.5 6206.7 6310.4 6319.5 6429.9 6498.0 6371.0 6434.1 6448.1 6480.1 6480.7 6221.6 6225.4 6226.3 6228.2 6228.3 06:46:06 INFO - PID 14853 | 06:46:06 INFO - PID 14853 | [#1] ext.html Cycles:180 Average:39186.39 Median:3614.11 stddev:56295.36 (1557.7%) stddev-sans-first:56379.41 06:46:06 INFO - PID 14853 | Values: 777.5 855.2 882.7 883.7 1137.6 30719.8 31318.1 41178.4 41775.6 41776.6 41316.0 41353.6 41885.4 41938.8 42036.8 7170.4 7483.6 7637.1 7643.7 7725.0 7485.7 7495.4 7574.2 7583.2 7584.7 7569.9 7626.2 7627.1 7630.7 7632.4 7527.4 7538.5 7576.6 7584.4 7601.6 7437.5 7468.7 7527.9 7549.5 7569.1 37946.6 38111.0 38375.4 38379.2 38518.8 3565.8 3584.1 3603.9 3613.8 3614.4 30606.7 30845.8 31123.2 31327.5 31357.5 4698.4 4902.3 4902.9 4915.4 4926.2 196024.0 196568.0 198160.0 198702.0 199375.0 48756.5 48870.3 49122.3 49995.3 50153.7 51824.2 51880.7 51894.0 51908.7 51951.7 15989.0 16392.5 16400.4 16666.6 16748.3 11960.0 11960.5 12159.7 12210.1 13365.5 14400.7 14434.2 14514.3 14595.7 14662.9 5785.8 5862.4 5956.2 6017.5 6042.9 993.3 996.9 1002.9 1033.3 1039.6 22673.3 29096.3 29541.3 29545.4 29939.7 1091.3 1099.6 1110.7 1121.8 1123.3 11877.7 12493.9 16079.2 16121.2 16305.8 243173.0 244735.0 245593.0 245635.0 246151.0 56129.7 56375.7 56709.4 56732.4 57030.1 1469.2 1497.9 1500.6 1501.9 1509.0 26925.6 27820.4 27855.3 27991.3 28312.9 37579.8 37821.1 37863.8 37873.0 37879.2 204033.0 205248.0 205694.0 207584.0 207621.0 33468.0 37246.8 37843.0 38012.2 38141.4 45694.5 46086.8 46247.0 46727.5 46853.5 33524.5 34697.0 34756.3 34879.7 35488.0 33225.2 33314.2 33904.5 34222.5 34330.0 36585.3 37096.4 37104.6 37145.0 37478.6 32502.8 32823.7 33455.2 33597.7 34265.8 24903.9 25007.4 25045.7 25181.0 25646.2 06:46:06 INFO - PID 14853 | 06:46:06 INFO - PID 14853 | [#2] jquery.html Cycles:180 Average:35785.86 Median:23229.33 stddev:86852.96 (373.9%) stddev-sans-first:87056.39 06:46:06 INFO - PID 14853 | Values: 583.3 585.8 597.3 606.6 610.3 21636.6 22355.6 22458.8 22460.3 22492.2 24226.3 25279.5 26483.0 26627.5 26799.0 6513.8 6652.1 6655.4 6663.1 6677.4 5915.3 6483.7 6518.9 6563.4 6601.1 6422.0 6470.6 6470.6 6471.5 6485.9 6447.2 6463.8 6475.3 6482.5 6487.5 6001.5 6037.6 6041.4 6068.4 6070.7 27943.9 28677.9 28987.7 29195.6 30487.5 1961.3 2013.0 2014.2 2014.9 2015.5 18636.7 19172.2 19485.7 19625.1 19626.5 2345.4 2348.4 2406.2 2416.1 2433.3 134886.0 139556.0 139584.0 144215.3 146498.0 14959.3 15357.2 15406.2 15526.1 15669.6 23658.3 23665.6 23716.3 23734.5 23782.6 10103.8 10409.6 10430.3 10566.9 10696.4 9591.8 9616.6 9636.8 9746.0 9746.8 8721.5 9436.5 9460.0 9529.3 9698.4 2678.4 2808.6 2845.6 2869.3 2873.1 908.9 930.7 938.2 974.2 979.2 19275.9 19355.2 20236.9 23246.7 24723.8 1013.0 1030.8 1045.9 1046.2 1072.9 11087.2 11090.1 11231.5 11581.4 11684.6 504287.0 506813.0 521984.0 523267.0 523840.0 121296.4 121784.4 122124.0 123228.4 123532.0 1249.0 1289.9 1306.9 1309.6 1313.4 17037.4 17673.0 18183.4 18711.7 18715.8 55061.0 55122.0 55904.0 57366.7 57583.4 69503.0 69789.7 70203.3 70280.0 70517.0 12391.1 12976.8 14483.8 14963.6 15100.7 18478.1 22176.9 23212.0 23692.1 23818.0 18243.4 18332.5 18639.3 18672.5 18716.5 16157.3 16583.0 16907.7 16957.8 17488.0 18411.7 18667.8 19007.6 19034.0 19094.0 14655.9 14702.2 14714.1 14738.9 14878.5 18213.7 18229.5 18420.6 18726.7 18808.6 06:46:06 INFO - PID 14853 | 06:46:06 INFO - PID 14853 | [#3] mootools.html Cycles:180 Average:8595.77 Median:2701.51 stddev:5833.36 (215.9%) stddev-sans-first:5824.16 06:46:06 INFO - PID 14853 | Values: 1328.0 1380.4 1408.2 1409.2 1409.6 13649.2 13872.7 14277.6 14297.6 14312.1 14227.8 14594.9 14606.9 14607.8 14616.0 2739.3 2791.9 2792.4 2792.6 2799.9 2620.2 2801.9 2803.0 2806.4 2807.7 2695.2 2707.8 2724.1 2734.2 2735.8 2541.2 2560.3 2583.4 2585.4 2710.3 2603.5 2635.9 2636.1 2658.9 2659.9 13302.6 13563.3 13620.8 13644.3 13648.2 7582.2 7823.0 7841.4 7858.6 7873.2 4892.9 5052.9 5131.2 5141.2 5162.9 1738.7 1765.3 1772.6 1828.6 1828.8 21102.5 21376.4 21377.0 21514.2 21542.5 6416.6 6417.2 6439.5 6559.3 6599.1 15720.9 15726.5 15738.9 15744.8 15747.8 7329.1 7460.9 7495.7 7502.8 7529.8 6736.1 6838.5 6940.9 7052.0 7056.9 4931.9 4970.4 5015.4 5047.2 5081.7 1456.3 1457.8 1460.5 1468.9 1494.7 848.2 858.8 867.2 881.3 902.4 6711.4 7006.4 7065.3 7128.1 7133.2 712.3 735.8 975.4 996.4 1010.0 4902.2 4919.5 5012.7 5380.3 5545.5 19050.5 19573.7 19659.0 19814.2 19958.5 18890.9 19347.9 19589.0 19678.4 19709.9 9586.8 9746.5 9750.4 9789.4 9832.9 7403.4 7804.8 7962.0 8179.9 8342.5 16470.3 16638.1 16838.7 16935.5 17235.6 16711.8 17009.1 17088.4 17105.5 17260.6 11372.4 11384.9 11563.2 11576.1 11697.4 12630.9 13041.0 13050.5 13051.5 13058.5 10382.6 10568.9 10648.5 10753.6 10805.7 9869.5 10338.1 10407.7 10422.9 10540.9 9561.1 9720.1 9728.2 9734.5 9757.3 6808.9 6929.5 6979.5 7094.4 7110.7 6237.2 6578.9 6651.9 6806.1 6870.5 06:46:06 INFO - PID 14853 | 06:46:06 INFO - PID 14853 | [#4] prototype.html Cycles:180 Average:5644.24 Median:6195.66 stddev:1504.39 (24.3%) stddev-sans-first:1458.22 06:46:06 INFO - PID 14853 | Values: 499.8 500.0 526.6 529.1 540.6 6194.0 6236.4 6250.1 6296.6 6318.8 6077.9 6134.0 6170.6 6258.5 6277.0 5185.9 5198.9 5230.4 5266.0 5276.9 5140.2 5217.7 5218.8 5254.7 5267.1 5136.0 5198.7 5213.9 5216.9 5220.6 5158.4 5165.9 5219.9 5247.2 5250.1 4889.9 4895.9 4912.6 4913.6 4948.3 6186.3 6189.9 6197.3 6228.9 6258.4 5997.6 6039.7 6040.0 6061.4 6106.7 6652.3 6654.5 6665.7 6682.0 6714.4 5344.9 5348.2 5376.8 5381.9 5408.4 6973.4 7012.5 7036.9 7057.4 7089.1 5472.4 5481.5 5507.8 5511.2 5562.9 5599.4 5604.0 5608.5 5611.7 5650.8 5900.2 5939.2 5944.3 6026.4 6052.7 6466.5 6599.2 6607.6 6707.4 6727.6 1861.5 1885.7 1953.2 1972.0 1973.2 1431.6 1444.8 1463.5 1465.8 1484.8 5565.3 5576.9 5680.8 5715.6 5780.8 6725.9 6730.9 6782.5 6792.8 6793.0 5610.7 5684.0 5759.2 5763.8 5768.6 3623.9 3639.2 3645.9 3649.9 3673.2 6555.6 6561.9 6566.0 6601.5 6672.5 6931.2 6940.5 6980.4 7000.6 7011.4 6534.6 6580.2 6591.4 6614.8 6646.9 6769.3 6781.5 6784.0 6807.2 6809.6 6626.3 6669.1 6683.7 6696.2 6715.8 6518.2 6536.5 6544.8 6568.6 6578.6 5029.8 5032.6 5064.3 5105.5 5111.6 6353.7 6527.2 6563.8 6746.7 6864.9 6428.0 6521.7 6523.5 6571.2 6595.3 6462.7 6467.7 6539.3 6540.3 6622.0 6419.0 6435.1 6459.5 6459.9 6504.2 6449.8 6468.8 6477.4 6517.0 6646.6 6222.7 6344.9 6377.8 6394.4 6396.4 06:46:06 INFO - PID 14853 | 06:46:06 INFO - PID 14853 | [#5] yui.html Cycles:180 Average:22226.00 Median:19716.86 stddev:29370.87 (149.0%) stddev-sans-first:29409.61 06:46:06 INFO - PID 14853 | Values: 899.8 917.7 921.3 932.7 935.3 17964.1 18819.9 18839.8 18886.8 18944.4 19585.1 21236.5 21346.3 21369.1 21395.0 1009.8 1029.7 1032.1 1032.3 1034.5 975.2 1029.3 1034.9 1047.1 1047.5 1099.2 1099.4 1100.3 1100.6 1101.0 1087.5 1089.7 1090.5 1098.3 1098.7 795.2 795.6 796.6 798.0 803.0 19161.0 19296.7 19517.1 19534.3 20017.6 19975.8 20052.6 20543.5 20588.6 20590.5 14650.3 14870.3 14929.6 14950.7 15146.8 3590.9 3609.9 3610.7 3623.8 3627.0 118495.0 120204.4 123379.4 126122.0 129496.4 15542.6 15574.0 15589.0 15912.2 15918.3 29538.9 29869.7 30273.2 30303.8 30362.1 8077.8 8577.8 8677.9 8693.5 8766.4 4174.7 4252.4 4254.1 4268.9 4271.2 4651.9 4893.0 4958.7 5111.8 5947.5 1119.4 1127.7 1136.9 1142.9 1144.3 671.6 671.7 680.4 688.3 690.6 11487.6 11972.2 12296.3 12524.9 12550.4 581.5 582.1 582.7 584.2 591.5 5467.7 5632.2 5644.9 5740.8 5815.2 98360.0 99656.5 101849.0 103347.0 105872.0 82192.6 85200.1 85347.6 86142.0 87304.0 76857.0 77098.6 78317.0 79294.2 80886.0 11586.4 12068.5 12247.6 12326.4 12427.3 33953.2 34758.0 35016.8 36174.6 37836.4 45515.5 47279.0 47362.5 48031.3 65479.7 16731.0 18621.9 18624.7 19027.2 19284.5 20211.6 20351.4 21013.5 21116.7 21726.8 18335.4 18561.4 19441.8 19507.9 19580.5 19419.0 19474.4 19524.0 19591.5 19842.2 17895.2 18112.7 18368.9 18634.2 18706.7 13535.3 13622.4 13751.2 14166.6 14328.4 13733.1 14326.9 14341.3 14994.0 14994.8 06:46:06 INFO - PID 14853 | -------- Summary: end -------- 06:46:06 INFO - PID 14853 | 06:46:06 INFO - TEST-INFO | 14853: exit 0 06:46:06 INFO - TEST-OK | dromaeo_css | took 1112376ms 06:46:06 INFO - TEST-START | kraken 06:46:06 INFO - Initialising browser for kraken test... 06:46:06 INFO - Application command: /builds/slave/test/build/application/firefox/firefox http://localhost:51808/getInfo.html -profile /tmp/tmpabGpwA/profile 06:46:06 INFO - TEST-INFO | started process 15212 (/builds/slave/test/build/application/firefox/firefox http://localhost:51808/getInfo.html) 06:46:12 INFO - TEST-INFO | 15212: exit 0 06:46:12 INFO - Browser initialized. 06:46:12 INFO - Running cycle 1/1 for kraken test... 06:46:12 INFO - TEST-INFO | started process 15423 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpabGpwA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpnoisy -tpcycles 1 -tppagecycles 1) 06:46:13 INFO - PID 15423 | 06:46:13 INFO - PID 15423 | (/builds/slave/test/build/application/firefox/firefox:15471): Pango-WARNING **: error opening config file '/home/cltbld/.pangorc': Permission denied 06:46:13 INFO - PID 15423 | 06:46:23 INFO - PID 15423 | RSS: Main: 171413504 06:46:23 INFO - PID 15423 | 06:46:26 INFO - PID 15423 | Cycle 1(1): loaded http://localhost:51808/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51808/tests/kraken/driver.html?testName=audio-beat-detection) 06:46:27 INFO - PID 15423 | RSS: Main: 176750592 06:46:27 INFO - PID 15423 | 06:46:29 INFO - PID 15423 | Cycle 1(1): loaded http://localhost:51808/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51808/tests/kraken/driver.html?testName=audio-dft) 06:46:30 INFO - PID 15423 | RSS: Main: 178171904 06:46:30 INFO - PID 15423 | 06:46:33 INFO - PID 15423 | Cycle 1(1): loaded http://localhost:51808/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51808/tests/kraken/driver.html?testName=audio-fft) 06:46:34 INFO - PID 15423 | RSS: Main: 171798528 06:46:34 INFO - PID 15423 | 06:46:36 INFO - PID 15423 | Cycle 1(1): loaded http://localhost:51808/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51808/tests/kraken/driver.html?testName=audio-oscillator) 06:46:36 INFO - PID 15423 | RSS: Main: 173092864 06:46:36 INFO - PID 15423 | 06:46:39 INFO - PID 15423 | Cycle 1(1): loaded http://localhost:51808/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51808/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:46:39 INFO - PID 15423 | RSS: Main: 172789760 06:46:39 INFO - PID 15423 | 06:46:42 INFO - PID 15423 | Cycle 1(1): loaded http://localhost:51808/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51808/tests/kraken/driver.html?testName=imaging-darkroom) 06:46:43 INFO - PID 15423 | RSS: Main: 175730688 06:46:43 INFO - PID 15423 | 06:46:46 INFO - PID 15423 | Cycle 1(1): loaded http://localhost:51808/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51808/tests/kraken/driver.html?testName=imaging-desaturate) 06:46:47 INFO - PID 15423 | RSS: Main: 175697920 06:46:47 INFO - PID 15423 | 06:46:50 INFO - PID 15423 | Cycle 1(1): loaded http://localhost:51808/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51808/tests/kraken/driver.html?testName=json-parse-financial) 06:46:50 INFO - PID 15423 | RSS: Main: 175927296 06:46:50 INFO - PID 15423 | 06:46:52 INFO - PID 15423 | Cycle 1(1): loaded http://localhost:51808/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51808/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:46:53 INFO - PID 15423 | RSS: Main: 175976448 06:46:53 INFO - PID 15423 | 06:46:54 INFO - PID 15423 | Cycle 1(1): loaded http://localhost:51808/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51808/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:46:55 INFO - PID 15423 | RSS: Main: 176246784 06:46:55 INFO - PID 15423 | 06:46:57 INFO - PID 15423 | Cycle 1(1): loaded http://localhost:51808/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51808/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:46:58 INFO - PID 15423 | RSS: Main: 173477888 06:46:58 INFO - PID 15423 | 06:47:01 INFO - PID 15423 | Cycle 1(1): loaded http://localhost:51808/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51808/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:47:01 INFO - PID 15423 | RSS: Main: 174333952 06:47:01 INFO - PID 15423 | 06:47:04 INFO - PID 15423 | Cycle 1(1): loaded http://localhost:51808/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51808/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:47:05 INFO - PID 15423 | RSS: Main: 173785088 06:47:05 INFO - PID 15423 | 06:47:07 INFO - PID 15423 | Cycle 1(1): loaded http://localhost:51808/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51808/tests/kraken/driver.html?testName=ai-astar) 06:47:07 INFO - PID 15423 | RSS: Main: 175333376 06:47:07 INFO - PID 15423 | 06:47:07 INFO - PID 15423 | __start_tp_report 06:47:07 INFO - PID 15423 | _x_x_mozilla_page_load 06:47:07 INFO - PID 15423 | _x_x_mozilla_page_load_details 06:47:07 INFO - PID 15423 | |i|pagename|runs| 06:47:07 INFO - PID 15423 | |0;ai-astar;101;110;103;110;110;116;110;101;112;112 06:47:07 INFO - PID 15423 | |1;audio-beat-detection;152;121;144;173;117;151;145;123;174;117 06:47:07 INFO - PID 15423 | |2;audio-dft;165;166;163;163;162;166;171;167;162;162 06:47:07 INFO - PID 15423 | |3;audio-fft;74;75;74;179;75;75;74;74;153;75 06:47:07 INFO - PID 15423 | |4;audio-oscillator;89;80;132;81;81;81;130;81;81;127 06:47:07 INFO - PID 15423 | |5;imaging-gaussian-blur;116;114;114;114;117;114;114;113;115;115 06:47:07 INFO - PID 15423 | |6;imaging-darkroom;160;151;151;150;150;150;151;151;151;151 06:47:07 INFO - PID 15423 | |7;imaging-desaturate;94;94;94;94;94;94;94;95;93;98 06:47:07 INFO - PID 15423 | |8;json-parse-financial;61;56;55;56;56;56;55;55;56;55 06:47:07 INFO - PID 15423 | |9;json-stringify-tinderbox;54;54;54;54;54;54;54;54;55;54 06:47:07 INFO - PID 15423 | |10;stanford-crypto-aes;92;79;79;89;79;89;78;87;79;79 06:47:07 INFO - PID 15423 | |11;stanford-crypto-ccm;128;140;128;127;137;140;127;130;131;163 06:47:07 INFO - PID 15423 | |12;stanford-crypto-pbkdf2;181;174;190;178;174;180;186;176;183;182 06:47:07 INFO - PID 15423 | |13;stanford-crypto-sha256-iterative;72;74;70;74;70;71;71;77;71;70 06:47:07 INFO - PID 15423 | __end_tp_report 06:47:07 INFO - PID 15423 | __start_cc_report 06:47:07 INFO - PID 15423 | _x_x_mozilla_cycle_collect,946 06:47:07 INFO - PID 15423 | __end_cc_report 06:47:07 INFO - PID 15423 | __startTimestamp1500990427651__endTimestamp 06:47:07 INFO - PID 15423 | 06:47:07 INFO - PID 15423 | ------- Summary: start ------- 06:47:07 INFO - PID 15423 | Number of tests: 14 06:47:07 INFO - PID 15423 | 06:47:07 INFO - PID 15423 | [#0] ai-astar Cycles:10 Average:108.50 Median:110.00 stddev:5.08 (4.6%) stddev-sans-first:4.61 06:47:07 INFO - PID 15423 | Values: 101.0 110.0 103.0 110.0 110.0 116.0 110.0 101.0 112.0 112.0 06:47:07 INFO - PID 15423 | 06:47:07 INFO - PID 15423 | [#1] audio-beat-detection Cycles:10 Average:141.70 Median:148.00 stddev:21.68 (14.6%) stddev-sans-first:22.67 06:47:07 INFO - PID 15423 | Values: 152.0 121.0 144.0 173.0 117.0 151.0 145.0 123.0 174.0 117.0 06:47:07 INFO - PID 15423 | 06:47:07 INFO - PID 15423 | [#2] audio-dft Cycles:10 Average:164.70 Median:165.50 stddev:2.91 (1.8%) stddev-sans-first:3.08 06:47:07 INFO - PID 15423 | Values: 165.0 166.0 163.0 163.0 162.0 166.0 171.0 167.0 162.0 162.0 06:47:07 INFO - PID 15423 | 06:47:07 INFO - PID 15423 | [#3] audio-fft Cycles:10 Average:92.80 Median:74.50 stddev:39.07 (52.4%) stddev-sans-first:40.84 06:47:07 INFO - PID 15423 | Values: 74.0 75.0 74.0 179.0 75.0 75.0 74.0 74.0 153.0 75.0 06:47:07 INFO - PID 15423 | 06:47:07 INFO - PID 15423 | [#4] audio-oscillator Cycles:10 Average:96.30 Median:81.00 stddev:23.20 (28.6%) stddev-sans-first:24.45 06:47:07 INFO - PID 15423 | Values: 89.0 80.0 132.0 81.0 81.0 81.0 130.0 81.0 81.0 127.0 06:47:07 INFO - PID 15423 | 06:47:07 INFO - PID 15423 | [#5] imaging-gaussian-blur Cycles:10 Average:114.60 Median:114.50 stddev:1.17 (1.0%) stddev-sans-first:1.13 06:47:07 INFO - PID 15423 | Values: 116.0 114.0 114.0 114.0 117.0 114.0 114.0 113.0 115.0 115.0 06:47:07 INFO - PID 15423 | 06:47:07 INFO - PID 15423 | [#6] imaging-darkroom Cycles:10 Average:151.60 Median:151.00 stddev:2.99 (2.0%) stddev-sans-first:0.50 06:47:07 INFO - PID 15423 | Values: 160.0 151.0 151.0 150.0 150.0 150.0 151.0 151.0 151.0 151.0 06:47:07 INFO - PID 15423 | 06:47:07 INFO - PID 15423 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 06:47:07 INFO - PID 15423 | Values: 94.0 94.0 94.0 94.0 94.0 94.0 94.0 95.0 93.0 98.0 06:47:07 INFO - PID 15423 | 06:47:07 INFO - PID 15423 | [#8] json-parse-financial Cycles:10 Average:56.10 Median:56.00 stddev:1.79 (3.2%) stddev-sans-first:0.53 06:47:07 INFO - PID 15423 | Values: 61.0 56.0 55.0 56.0 56.0 56.0 55.0 55.0 56.0 55.0 06:47:07 INFO - PID 15423 | 06:47:07 INFO - PID 15423 | [#9] json-stringify-tinderbox Cycles:10 Average:54.10 Median:54.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 06:47:07 INFO - PID 15423 | Values: 54.0 54.0 54.0 54.0 54.0 54.0 54.0 54.0 55.0 54.0 06:47:07 INFO - PID 15423 | 06:47:07 INFO - PID 15423 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:83.00 stddev:5.52 (6.6%) stddev-sans-first:4.80 06:47:07 INFO - PID 15423 | Values: 92.0 79.0 79.0 89.0 79.0 89.0 78.0 87.0 79.0 79.0 06:47:07 INFO - PID 15423 | 06:47:07 INFO - PID 15423 | [#11] stanford-crypto-ccm Cycles:10 Average:135.10 Median:134.00 stddev:11.08 (8.3%) stddev-sans-first:11.45 06:47:07 INFO - PID 15423 | Values: 128.0 140.0 128.0 127.0 137.0 140.0 127.0 130.0 131.0 163.0 06:47:07 INFO - PID 15423 | 06:47:07 INFO - PID 15423 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.40 Median:181.50 stddev:5.17 (2.8%) stddev-sans-first:5.48 06:47:07 INFO - PID 15423 | Values: 181.0 174.0 190.0 178.0 174.0 180.0 186.0 176.0 183.0 182.0 06:47:07 INFO - PID 15423 | 06:47:07 INFO - PID 15423 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:71.50 stddev:2.31 (3.2%) stddev-sans-first:2.45 06:47:07 INFO - PID 15423 | Values: 72.0 74.0 70.0 74.0 70.0 71.0 71.0 77.0 71.0 70.0 06:47:07 INFO - PID 15423 | -------- Summary: end -------- 06:47:07 INFO - PID 15423 | 06:47:07 INFO - PID 15423 | *** UTM:SVC TimerManager:registerTimer called after profile-before-change notification. Ignoring timer registration for id: telemetry_modules_ping 06:47:08 INFO - TEST-INFO | 15423: exit 0 06:47:08 INFO - TEST-OK | kraken | took 61642ms 06:47:08 INFO - SUITE-END | took 1174s 06:47:08 INFO - Completed test suite (00:19:34) 06:47:08 INFO - javascript benchmark 06:47:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 8518.375339935234, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3093.242155671861, 3160.27313717845, 3165.699258570435, 3193.712565869071, 3203.8398080096003, 6081.331053584102, 6152.138700581917, 6156.261248650163, 6251.12484252205, 6335.778247761329, 6091.695415229243, 6133.110698948661, 6212.471939885104, 6221.0, 6268.780592679257, 5575.330960284771, 5651.802186923458, 5719.599628026019, 5727.026405511052, 5769.7692092316365, 5588.329400471929, 5781.855453613652, 5801.82594522165, 5801.883962320751, 5814.069748840187, 5687.118496633028, 5708.914366284509, 5785.942140578624, 5802.680852553129, 5811.128330750379, 5507.917381239285, 5596.776128954837, 5665.8583535411535, 5709.77160913563, 5773.480386765212, 5628.81891490488, 5715.428457154293, 5718.914216286759, 5718.942810571924, 5728.0, 6148.78479253224, 6156.630602163839, 6243.687815609247, 6268.091126786636, 6279.466245369149, 6504.861649211416, 6535.869282614369, 6603.471722262208, 6621.337866213388, 6711.463082953352, 6757.966210168966, 6764.526483146182, 6805.149356330458, 6815.114035175445, 6821.147356580427, 6136.478399336062, 6172.29018662855, 6192.845178870564, 6240.438360547572, 6297.118403423525, 6638.834029149213, 6742.056112144303, 6842.418394436529, 6978.162620485473, 6982.0, 6483.481321494363, 6490.8052758417325, 6494.740210391626, 6503.089567460559, 6512.283648798629, 6594.307597702268, 6673.998900165014, 6692.096566963398, 6693.0, 6701.29636388182, 6549.770758023446, 6550.639714815636, 6590.703418346186, 6673.966630166915, 6677.565958212701, 6461.450776683941, 6561.376669216417, 6571.178602674666, 6653.700583473756, 6700.128983232149, 5314.840554783363, 5322.92015619766, 5326.760295786699, 5328.813491527778, 5338.759755810997, 4582.1293954148605, 4604.746738929391, 4633.49031606523, 4640.907181856344, 4673.742944138037, 5677.545796336283, 5739.995500787346, 5757.510611597977, 5763.250777398911, 5780.479756821822, 6540.9345906541275, 6626.271110177877, 6642.1033160523675, 6685.0, 6703.93296067033, 5740.942590574125, 5756.42435756421, 5759.596828221985, 5763.077907534775, 5767.077267637158, 5835.387284335168, 5842.415758424208, 5854.414558544197, 5859.267591551056, 5859.53123750099, 6400.807975760735, 6451.0, 6475.190601174853, 6475.417212450902, 6487.2539657939, 6662.76680316206, 6674.466042716668, 6699.0, 6708.765193218214, 6712.563683360566, 6461.870762584816, 6468.741250349934, 6495.0, 6497.927841906033, 6546.639934803631, 6558.868822623616, 6567.671616419256, 6645.6677166140535, 6666.0, 6675.198976122702, 6601.636909969806, 6707.228668702966, 6708.83227919306, 6731.394174524316, 6817.488688348294, 6398.71205795731, 6406.423421892052, 6431.903521447276, 6438.90341644885, 6439.356064393523, 5523.0, 6442.677866106582, 6468.288488266381, 6511.34886511364, 6593.472522198117, 6206.658633775005, 6310.368963103653, 6319.46284565817, 6429.8714025720155, 6498.0, 6371.0, 6434.099226108442, 6448.097266382804, 6480.060391243149, 6480.70836812354, 6221.626702397871, 6225.408586184305, 6226.346233645402, 6228.22147231596, 6228.252609686867], "value": 6062.063936882327, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.4518964130289, 855.170484629909, 882.7087061269782, 883.6597909804725, 1137.5677242647794, 30719.84640076802, 31318.060458186235, 41178.38232426516, 41775.58224417755, 41776.582234177724, 41316.0, 41353.58646413535, 41885.371719424234, 41938.790306048424, 42036.78981605088, 7170.390516806077, 7483.550986940773, 7637.083549973983, 7643.694252229904, 7725.0, 7485.700571977114, 7495.400367970577, 7574.166841647414, 7583.241675832428, 7584.65869035892, 7569.886451703229, 7626.161122276545, 7627.084749830001, 7630.694772209133, 7632.427567932399, 7527.39780817536, 7538.472306938516, 7576.621168941531, 7584.43116766242, 7601.619919004083, 7437.479376443651, 7468.701251949916, 7527.924720752777, 7549.5470271783315, 7569.091708994956, 37946.62053379459, 38111.04722381935, 38375.42436863449, 38379.23241535181, 38518.80740596279, 3565.839537220805, 3584.1039740064984, 3603.873864414733, 3613.7831730096277, 3614.439761836893, 30606.69393306083, 30845.845770771226, 31123.221919452193, 31327.53008704871, 31357.52963705546, 4698.365720627706, 4902.264660300948, 4902.852914412573, 4915.434725006634, 4926.236433352836, 196024.0198799011, 196568.0, 198160.0, 198702.0, 199375.0, 48756.512434875905, 48870.26694599584, 49122.26316605254, 49995.250071248236, 50153.74923125361, 51824.22263666048, 51880.74059629753, 51894.0, 51908.74045629748, 51951.74024129931, 15989.040657560583, 16392.508224753277, 16400.425985090464, 16666.58333541671, 16748.330066797193, 11960.0, 11960.461779219782, 12159.696007599881, 12210.145289829805, 13365.465381384636, 14400.711985760436, 14434.206118663575, 14514.274286285643, 14595.708085838223, 14662.853371466148, 5785.768569257267, 5862.443067908542, 5956.225690660186, 6017.488513476404, 6042.909356359658, 993.2600212841479, 996.9102780749768, 1002.9147522460527, 1033.3076838518211, 1039.5841663334575, 22673.319800406014, 29096.272593184916, 29541.26146846303, 29545.409091818474, 29939.700602993693, 1091.2524920429373, 1099.5931505343074, 1110.6834552152598, 1121.7924683933336, 1123.309164863603, 11877.653032887703, 12493.875061249271, 16079.196040197943, 16121.193940302937, 16305.836941630669, 243173.0, 244735.0, 245593.0, 245635.0, 246151.0, 56129.71935140298, 56375.71812140913, 56709.43290567124, 56732.43267567354, 57030.14454783181, 1469.177260733971, 1497.9400823966919, 1500.647347873249, 1501.8798496120285, 1508.9773653395207, 26925.596116057885, 27820.44359112766, 27855.303617409725, 27991.300217494725, 28312.85843570769, 37579.81210093932, 37821.05447363838, 37863.81068094752, 37873.0, 37879.2424151521, 204033.0, 205248.0, 205694.0, 207584.0, 207621.0, 33468.0, 37246.813765930994, 37843.0, 38012.23975520529, 38141.4278785824, 45694.543054569025, 46086.769566151954, 46247.0, 46727.53272467232, 46853.531464684915, 33524.49713254254, 34697.0, 34756.30487390289, 34879.65120348764, 35488.0, 33225.24320279383, 33314.16714582155, 33904.49143262902, 34222.48666269958, 34330.0, 36585.268294634494, 37096.443553347264, 37104.628953711195, 37145.0, 37478.62521374752, 32502.837485813365, 32823.67176328206, 33455.16362090967, 33597.66402335945, 34265.828670856485, 24903.875480622482, 25007.374815629755, 25045.74954250507, 25181.0, 25646.230613081636], "value": 17690.762250539487, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [583.2942140010587, 585.8154681275398, 597.2683462758122, 606.6178307666171, 610.3073012131231, 21636.56726865464, 22355.55288894223, 22458.775412245894, 22460.32619021428, 22492.200623950084, 24226.27321180363, 25279.494410111787, 26483.0, 26627.467450650976, 26799.0, 6513.80458586242, 6652.06871038055, 6655.367740064686, 6663.133792606978, 6677.399034086931, 5915.260592425947, 6483.675816209195, 6518.902216466757, 6563.409293163614, 6601.075849381091, 6421.967890160543, 6470.611763294194, 6470.644114573696, 6471.514636402265, 6485.935140648604, 6447.161868957052, 6463.773767918124, 6475.32009139043, 6482.513811464159, 6487.545871788977, 6001.5198784097165, 6037.63774173551, 6041.365656606037, 6068.393160683941, 6070.696465176768, 27943.86028069867, 28677.856610717023, 28987.710122898923, 29195.56206656902, 30487.542686859713, 1961.3037371733114, 2013.0035632362074, 2014.1540552967642, 2014.909329080195, 2015.4558269267363, 18636.72044919327, 19172.233110675556, 19485.707714384294, 19625.116869740898, 19626.50933726654, 2345.401922509749, 2348.4011577047913, 2406.1818981546185, 2416.1301931304715, 2433.2578563538113, 134886.0, 139556.0, 139584.0, 144215.27892360577, 146498.0, 14959.326830292663, 15357.15535645528, 15406.152661603495, 15526.1460619667, 15669.608259793597, 23658.29025129249, 23665.645015324782, 23716.288511344686, 23734.525309493714, 23782.64326035111, 10103.84844227337, 10409.635662751767, 10430.269881108401, 10566.875065593182, 10696.41169735672, 9591.808163836684, 9616.615335386507, 9636.75908102303, 9745.951270243604, 9746.805063898682, 8721.520316382534, 9436.480993545421, 9459.952700236454, 9529.285303602257, 9698.418094914186, 2678.397360593851, 2808.5927540506514, 2845.6300680911763, 2869.2826793301674, 2873.1380585824168, 908.8954770201511, 930.7486978515898, 938.1603464898877, 974.2414941031507, 979.2068424576116, 19275.903620482088, 19355.225790968205, 20236.89881550583, 23246.65130023051, 24723.752762472504, 1012.9696109116591, 1030.835066389374, 1045.9215558833118, 1046.2205656785743, 1072.9141668666489, 11087.22389432732, 11090.112790976864, 11231.494582743797, 11581.363025033705, 11684.649460516199, 504287.0, 506813.0, 521984.0, 523267.0, 523840.0, 121296.39351803185, 121784.39107804581, 122124.0, 123228.38385808193, 123532.0, 1248.9750204995848, 1289.8903593194684, 1306.9281189534668, 1309.5547513845147, 1313.40240190713, 17037.40369087076, 17673.0, 18183.363582274556, 18711.71932421042, 18715.812841871953, 55061.0, 55122.0, 55904.0, 57366.7131664339, 57583.42416575948, 69503.0, 69789.65105174441, 70203.29796701968, 70280.0, 70517.0, 12391.132620716824, 12976.805347919977, 14483.782743259071, 14963.551093467213, 15100.697986040437, 18478.076096195404, 22176.88911555432, 23212.0, 23692.05231790778, 23818.0, 18243.361482348053, 18332.450026499228, 18639.2544298232, 18672.533186670444, 18716.532086697942, 16157.27292271827, 16583.0, 16907.746383804006, 16957.830421695624, 17488.03815790144, 18411.72382414238, 18667.813321866608, 19007.619847603248, 19034.0, 19094.0, 14655.92672036633, 14702.191379473803, 14714.117152970855, 14738.926305368834, 14878.479253226085, 18213.726794097834, 18229.45311640653, 18420.63158736791, 18726.71909921325, 18808.623827523646], "value": 12096.392373281235, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.0, 1380.3788295267127, 1408.1762169131064, 1409.1826740490517, 1409.6475881029742, 13649.249291288976, 13872.653183670413, 14277.643058923531, 14297.642558936019, 14312.069715468488, 14227.78658320126, 14594.927025364885, 14606.853931460682, 14607.78088328676, 14615.976881618291, 2739.2877851758485, 2791.8883244670187, 2792.3577577157266, 2792.6369571955615, 2799.930001749952, 2620.2008387441824, 2801.8739156737997, 2802.971970280302, 2806.3685670724026, 2807.719228077186, 2695.218386667874, 2707.810453268272, 2724.141895302983, 2734.1934129431766, 2735.7948153888537, 2541.224926397448, 2560.3215147985798, 2583.354161459635, 2585.418280886795, 2710.3088712378412, 2603.5313643544346, 2635.907743228997, 2636.077372919482, 2658.853763043032, 2659.853708046057, 13302.600921972356, 13563.254021028839, 13620.795688064687, 13644.317784110755, 13648.181109133484, 7582.203868593829, 7823.022122234721, 7841.411894107965, 7858.607069646495, 7873.173316801711, 4892.902141957176, 5052.898942021139, 5131.230315452674, 5141.15170996785, 5162.896742065138, 1738.7218045112847, 1765.2938824470186, 1772.5923037701273, 1828.5520047588293, 1828.826261505155, 21102.472438189016, 21376.358709238593, 21377.0, 21514.247001355034, 21542.461438464008, 6416.647084410309, 6417.229932408048, 6439.549231553746, 6559.344065593403, 6599.142111525567, 15720.92139539318, 15726.528204153894, 15738.9213053934, 15744.763828542582, 15747.842521574867, 7329.083864516935, 7460.888086678704, 7495.66269517873, 7502.812429689301, 7529.774106776806, 6736.124303840469, 6838.487113466411, 6940.930590694129, 7051.964740176369, 7056.92943070573, 4931.90136197274, 4970.378702662168, 5015.3730783652045, 5047.16721740916, 5081.669691470042, 1456.2936975566843, 1457.7521821290406, 1460.4523303761089, 1468.860458256464, 1494.6935878144955, 848.2196379331031, 858.7767180532982, 867.1935100356603, 881.259741816877, 902.3638334973828, 6711.395974362331, 7006.369426751617, 7065.258147894499, 7128.108986376703, 7133.215346311901, 712.3161764705836, 735.7829440315013, 975.3611384543135, 996.4220751963844, 1009.9646512372178, 4902.240152776325, 4919.4834542373255, 5012.699238045729, 5380.3274590676165, 5545.528630066489, 19050.52373690669, 19573.706394404096, 19659.0, 19814.216720495224, 19958.50103747418, 18890.905545472186, 19347.903260483607, 19589.0, 19678.409647710592, 19709.901450492944, 9586.808263834684, 9746.512674366253, 9750.41497510166, 9789.36369136018, 9832.9016709832, 7403.370713489198, 7804.804879878048, 7961.960190199244, 8179.895714078523, 8342.499450033018, 16470.341186352412, 16638.084905329837, 16838.66322673564, 16935.491935241964, 17235.56911077183, 16711.832881671027, 17009.14954252307, 17088.40190593323, 17105.486835394957, 17260.568485787455, 11372.43137843121, 11384.943075284571, 11563.248388854698, 11576.131790115944, 11697.356645384585, 12630.936845315715, 13041.0, 13050.477980881038, 13051.543195988095, 13058.542950996669, 10382.636607718694, 10568.89431105679, 10648.467576620984, 10753.569857205624, 10805.675829725122, 9869.457179855177, 10338.12125969301, 10407.739806504595, 10422.947885260828, 10540.947295263475, 9561.091696288842, 9720.125188733047, 9728.17310528613, 9734.513274336396, 9757.316987810786, 6808.931910681028, 6929.514933954575, 6979.511434199558, 7094.432445404458, 7110.715571377087, 6237.157983672328, 6578.934210657832, 6651.866962660816, 6806.081179040766, 6870.45036397097], "value": 6289.658544407075, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [499.8004788507581, 499.9550040496357, 526.5971531778192, 529.1005291005291, 540.6269673924992, 6194.0, 6236.438720515147, 6250.0624906263965, 6296.559240853142, 6318.778842740505, 6077.939220607793, 6134.0, 6170.629762214259, 6258.526517782629, 6276.968615156918, 5185.870353241162, 5198.8700282493055, 5230.372355317349, 5265.973670131644, 5276.894462110756, 5140.228965655163, 5217.713025783581, 5218.7651555679895, 5254.684718916858, 5267.104592219332, 5136.049830781318, 5198.662086964335, 5213.895722085556, 5216.895662086775, 5220.582353411718, 5158.40678321994, 5165.870853228681, 5219.947800521984, 5247.160454327328, 5250.109960414248, 4889.926651100236, 4895.947371315185, 4912.5578697917, 4913.606911447111, 4948.307236986825, 6186.329690983454, 6189.876202475925, 6197.318294987548, 6228.906566401508, 6258.374162583751, 5997.640141591475, 6039.667818269993, 6040.0, 6061.393860613904, 6106.72519736613, 6652.268250492442, 6654.500912431587, 6665.666716664147, 6681.966590167067, 6714.395704386579, 5344.893102137936, 5348.197770334442, 5376.838694839161, 5381.892362152774, 5408.35099788024, 6973.442124630017, 7012.509124361297, 7036.859262814715, 7057.36483716468, 7089.078419805443, 5472.425395333512, 5481.506664400144, 5507.779688812403, 5511.22842802008, 5562.888742225133, 5599.440055994368, 5603.971980140073, 5608.523275521545, 5611.691356975405, 5650.773969041193, 5900.20347253124, 5939.22790037301, 5944.286685597669, 6026.427489388501, 6052.6671033092725, 6466.450351720063, 6599.175103112111, 6607.612401395664, 6707.396334329934, 6727.62998035103, 1861.5346163459135, 1885.7454243677203, 1953.2187125150053, 1971.960560788805, 1973.1614064022733, 1431.5633731711928, 1444.826620805489, 1463.5463006468028, 1465.7508223602013, 1484.8218213814412, 5565.30433695788, 5576.944230557642, 5680.829575112753, 5715.599908006399, 5780.826575202751, 6725.932740672629, 6730.923052311607, 6782.525223234326, 6792.796216113525, 6793.0, 5610.719464026783, 5684.0, 5759.1649210865025, 5763.827085187451, 5768.567357448208, 3623.8912832615065, 3639.217568222845, 3645.9453108203397, 3649.927001459956, 3673.2469843682516, 6555.590548032196, 6561.868762624721, 6566.012464328719, 6601.5378923475855, 6672.466202703772, 6931.202911665223, 6940.479464040217, 6980.359615490355, 7000.579965202104, 7011.368976792113, 6534.575252608565, 6580.243272023587, 6591.43972762311, 6614.834629134214, 6646.933530664632, 6769.323067693192, 6781.491388146008, 6783.966080169567, 6807.183138023271, 6809.5573787705625, 6626.304238054935, 6669.1330127083165, 6683.732650693918, 6696.1629796275465, 6715.843553529833, 6518.185226846645, 6536.509761767981, 6544.8363790905605, 6568.6058836469965, 6578.572392794453, 5029.823956161663, 5032.597392208688, 5064.290999260033, 5105.540501354896, 5111.578484610859, 6353.745850166127, 6527.2167339919515, 6563.818512667765, 6746.730130794714, 6864.897026544706, 6427.967860160669, 6521.706523206372, 6523.510736694672, 6571.178602674666, 6595.340465953366, 6462.676866156768, 6467.741290348334, 6539.280679125388, 6540.280569137296, 6622.0, 6418.967905160444, 6435.131257280207, 6459.547831651739, 6459.870802583828, 6504.1869766279215, 6449.806505804833, 6468.803271394619, 6477.352264773485, 6517.0, 6646.567973081735, 6222.688865556795, 6344.936550634619, 6377.808665740035, 6394.424501794861, 6396.360363963567], "value": 5212.828009374918, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [899.8155378147478, 917.7338571814174, 921.2767977137948, 932.6782260120256, 935.3312381647121, 17964.10179491025, 18819.905900470494, 18839.811601883976, 18886.811131888677, 18944.431667049976, 19585.118669659863, 21236.4690882728, 21346.25288114916, 21369.145234190615, 21395.037223324947, 1009.8333774927147, 1029.7168278723373, 1032.076291718911, 1032.2825636182856, 1034.4672493665769, 975.2393133355959, 1029.2743615750878, 1034.9016843399866, 1047.0681093826502, 1047.512906498478, 1099.2140619457086, 1099.3953325670889, 1100.3342977498578, 1100.6202860013282, 1101.0200921180117, 1087.4508373271487, 1089.7221208591839, 1090.4820210400076, 1098.3080659184702, 1098.653924013933, 795.2484901767832, 795.6181033104142, 796.5698522797683, 797.9720709775188, 803.028335713787, 19161.0, 19296.71054934177, 19517.121729522063, 19534.31629892947, 20017.59964800696, 19975.80024199754, 20052.598948020957, 20543.486412839648, 20588.5882282355, 20590.485237869023, 14650.340734666966, 14870.330835112338, 14929.626759330995, 14950.70098598022, 15146.848531514765, 3590.856365745367, 3609.873654422083, 3610.6930910872607, 3623.836927338276, 3627.0, 118495.0, 120204.39897800455, 123379.38310308481, 126122.0, 129496.35251823775, 15542.611434714223, 15574.0, 15589.0, 15912.204389780465, 15918.283677234553, 29538.852305738335, 29869.701302987127, 30273.24316892051, 30303.848480757457, 30362.089137325915, 8077.798055048554, 8577.828443431097, 8677.913220867711, 8693.521856297837, 8766.38635295536, 4174.707770456039, 4252.383404406406, 4254.149170165979, 4268.914621707549, 4271.188474189894, 4651.930221046687, 4892.975535122301, 4958.652894297365, 5111.846644600668, 5947.464728174485, 1119.4346854838254, 1127.7067962329854, 1136.9488373023235, 1142.9028532574823, 1144.2848219862585, 671.563483735566, 671.6977360187935, 680.4454369688688, 688.2944981394111, 690.6270613868455, 11487.597934072268, 11972.178595467838, 12296.323702196287, 12524.937375313248, 12550.435230414654, 581.4882903045293, 582.1297160744714, 582.679526260555, 584.1558947321165, 591.4854076953078, 5467.72661366938, 5632.239647647597, 5644.85887852807, 5740.770369185186, 5815.185873977646, 98360.03279934361, 99656.50171749094, 101849.0, 103347.0, 105872.0, 82192.58903705444, 85200.14799851923, 85347.57326213454, 86141.99999999875, 87304.0, 76857.0, 77098.61450692822, 78317.0, 79294.20705792983, 80886.0, 11586.420678966186, 12068.517259309529, 12247.57133500359, 12326.445309960895, 12427.316497592357, 33953.15117122092, 34758.0, 35016.82491587526, 36174.63825361818, 37836.432453512665, 45515.54484455245, 47279.0, 47362.52637473719, 48031.27953080776, 65479.67260163669, 16731.0, 18621.90689046546, 18624.720629190302, 19027.238910443426, 19284.517887052934, 20211.595768084262, 20351.389458316273, 21013.474663133544, 21116.68324975096, 21726.782732172476, 18335.35826246075, 18561.35035273759, 19441.805581944565, 19507.902460487607, 19580.510487237934, 19419.0, 19474.415767526996, 19524.0, 19591.510212244237, 19842.20631174737, 17895.19471623806, 18112.72830907564, 18368.908155459136, 18634.161462733937, 18706.719399208752, 13535.323233838466, 13622.386992585556, 13751.243681597609, 14166.575002749521, 14328.355224015153, 13733.107348022346, 14326.856731432552, 14341.282935852956, 14994.0, 14994.775078373616], "value": 8982.357684365881, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 103.0, 110.0, 110.0, 116.0, 110.0, 101.0, 112.0, 112.0], "value": 108.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 121.0, 144.0, 173.0, 117.0, 151.0, 145.0, 123.0, 174.0, 117.0], "value": 141.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 163.0, 163.0, 162.0, 166.0, 171.0, 167.0, 162.0, 162.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 179.0, 75.0, 75.0, 74.0, 74.0, 153.0, 75.0], "value": 92.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 80.0, 132.0, 81.0, 81.0, 81.0, 130.0, 81.0, 81.0, 127.0], "value": 96.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 114.0, 114.0, 117.0, 114.0, 114.0, 113.0, 115.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 151.0, 151.0, 150.0, 150.0, 150.0, 151.0, 151.0, 151.0, 151.0], "value": 151.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 93.0, 98.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 56.0, 55.0, 56.0, 56.0, 56.0, 55.0, 55.0, 56.0, 55.0], "value": 56.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 55.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 79.0, 79.0, 89.0, 79.0, 89.0, 78.0, 87.0, 79.0, 79.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 140.0, 128.0, 127.0, 137.0, 140.0, 127.0, 130.0, 131.0, 163.0], "value": 135.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 174.0, 190.0, 178.0, 174.0, 180.0, 186.0, 176.0, 183.0, 182.0], "value": 180.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 74.0, 70.0, 74.0, 70.0, 71.0, 71.0, 77.0, 71.0, 70.0], "value": 72.0, "unit": "score"}]}]} 06:47:08 INFO - Return code: 0 06:47:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:47:08 INFO - # TBPL SUCCESS # 06:47:08 INFO - Running post-action listener: _package_coverage_data 06:47:08 INFO - Running post-action listener: _resource_record_post_action 06:47:08 INFO - [mozharness: 2017-07-25 13:47:08.918394Z] Finished run-tests step (success) 06:47:08 INFO - Running post-run listener: _resource_record_post_run 06:47:09 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 1323008; Write bytes: 440426496; Read time: 936; Write time: 319020 06:47:09 INFO - TinderboxPrint: CPU usage
13.1% 06:47:09 INFO - TinderboxPrint: I/O read bytes / time
1,323,008 / 936 06:47:09 INFO - TinderboxPrint: I/O write bytes / time
440,426,496 / 319,020 06:47:09 INFO - TinderboxPrint: CPU idle
8,262.0 (86.8%) 06:47:09 INFO - TinderboxPrint: CPU user
1,202.3 (12.6%) 06:47:09 INFO - TinderboxPrint: Swap in / out
0 / 0 06:47:09 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 114724864; Read time: 0; Write time: 91468 06:47:09 INFO - setup-mitmproxy - Wall time: 0s; CPU: Can't collect data; Read bytes: 0; Write bytes: 0; Read time: 0; Write time: 0 06:47:09 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 1318912; Write bytes: 325701632; Read time: 924; Write time: 227552 06:47:09 INFO - Running post-run listener: _upload_blobber_files 06:47:09 INFO - Blob upload gear active. 06:47:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:47: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 06:47: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', 'Cedar', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:47: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 Cedar -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:47:09 INFO - (blobuploader) - INFO - Open directory for files ... 06:47:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:47:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:47:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:47:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:47:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:47:10 INFO - (blobuploader) - INFO - Done attempting. 06:47:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:47:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:47:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:47:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:47:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:47:14 INFO - (blobuploader) - INFO - Done attempting. 06:47:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:47:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:47:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:47:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:47:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:47:15 INFO - (blobuploader) - INFO - Done attempting. 06:47:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:47:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:47:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:47:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:47:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:47:16 INFO - (blobuploader) - INFO - Done attempting. 06:47:16 INFO - (blobuploader) - INFO - Iteration through files over. 06:47:16 INFO - Return code: 0 06:47:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:47:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:47:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/fe7979bc3c3fcace2d6266f493f216dbace87a7fa4a611a5f9b2385f932c2de06b3a14ae9b9caa51df2b935f911b4b7070bb5594081e0e9389e375fbbc60b269", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/495febab8a2466e08cf4a62dd6eeacd59f47fb24b24c07b1f304fbf5b49b02347abc4921550e4c7cfbb87b751f5aefe22bb97eb78c8c8b6374f94955405974e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/f47dd556d6ce35a258dcd456dc985ee08fcf3f55cfc11d171ea3218e776ba48027dace353a107373553dd739cb95a22b600f43036418983ded0511b0134da771", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/8d5619e6d1c294aed98ffc2462d6884161a353610fc214f20067ff768adaaec91349e8d1111232ad22b06095bdb6f3f6177714b53a9014376c23779a433ad1ac"} 06:47:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:47:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:47:16 INFO - Contents: 06:47:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/fe7979bc3c3fcace2d6266f493f216dbace87a7fa4a611a5f9b2385f932c2de06b3a14ae9b9caa51df2b935f911b4b7070bb5594081e0e9389e375fbbc60b269", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/495febab8a2466e08cf4a62dd6eeacd59f47fb24b24c07b1f304fbf5b49b02347abc4921550e4c7cfbb87b751f5aefe22bb97eb78c8c8b6374f94955405974e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/f47dd556d6ce35a258dcd456dc985ee08fcf3f55cfc11d171ea3218e776ba48027dace353a107373553dd739cb95a22b600f43036418983ded0511b0134da771", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/8d5619e6d1c294aed98ffc2462d6884161a353610fc214f20067ff768adaaec91349e8d1111232ad22b06095bdb6f3f6177714b53a9014376c23779a433ad1ac"} 06:47:16 INFO - Running post-run listener: copy_logs_to_upload_dir 06:47:16 INFO - Copying logs to upload dir... 06:47:16 INFO - mkdir: /builds/slave/test/build/upload/logs 06:47:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.468664 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2017-07-25 06:47:15.988696) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-25 06:47:15.992851) ========= 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=3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/fe7979bc3c3fcace2d6266f493f216dbace87a7fa4a611a5f9b2385f932c2de06b3a14ae9b9caa51df2b935f911b4b7070bb5594081e0e9389e375fbbc60b269", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/495febab8a2466e08cf4a62dd6eeacd59f47fb24b24c07b1f304fbf5b49b02347abc4921550e4c7cfbb87b751f5aefe22bb97eb78c8c8b6374f94955405974e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/f47dd556d6ce35a258dcd456dc985ee08fcf3f55cfc11d171ea3218e776ba48027dace353a107373553dd739cb95a22b600f43036418983ded0511b0134da771", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/8d5619e6d1c294aed98ffc2462d6884161a353610fc214f20067ff768adaaec91349e8d1111232ad22b06095bdb6f3f6177714b53a9014376c23779a433ad1ac"} build_url:https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011267 build_url: 'https://queue.taskcluster.net/v1/task/DxLflJatRvehZ3Q2LSUt3Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/fe7979bc3c3fcace2d6266f493f216dbace87a7fa4a611a5f9b2385f932c2de06b3a14ae9b9caa51df2b935f911b4b7070bb5594081e0e9389e375fbbc60b269", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/495febab8a2466e08cf4a62dd6eeacd59f47fb24b24c07b1f304fbf5b49b02347abc4921550e4c7cfbb87b751f5aefe22bb97eb78c8c8b6374f94955405974e9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/f47dd556d6ce35a258dcd456dc985ee08fcf3f55cfc11d171ea3218e776ba48027dace353a107373553dd739cb95a22b600f43036418983ded0511b0134da771", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Cedar/sha512/8d5619e6d1c294aed98ffc2462d6884161a353610fc214f20067ff768adaaec91349e8d1111232ad22b06095bdb6f3f6177714b53a9014376c23779a433ad1ac"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-07-25 06:47:16.022443) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 06:47:16.022878) ========= 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=3a3620fb28aea1604ab609ef000001d2-1500988963.194742-107149427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004537 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-07-25 06:47:16.104670) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-25 06:47:16.105081) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-07-25 06:47:16.105511) ========= ========= Total master_lag: 0.19 =========