builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-041 starttime: 1494892401.76 results: success (0) revision: 3e166b6838931b3933ca274331f9e0e115af5cc0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-15 16:53:21.756027) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-15 16:53:21.756428) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-15 16:53:21.756865) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-15 16:53:21.779009) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-15 16:53:21.779263) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-15 16:53:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.1M=0s 2017-05-15 16:53:22 (25.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137579 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-15 16:53:21.938930) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-15 16:53:21.939267) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015777 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-15 16:53:22.002953) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-15 16:53:22.003260) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3e166b6838931b3933ca274331f9e0e115af5cc0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 3e166b6838931b3933ca274331f9e0e115af5cc0 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-15 16:53:22,900 truncating revision to first 12 chars 2017-05-15 16:53:22,901 Setting DEBUG logging. 2017-05-15 16:53:22,901 attempt 1/10 2017-05-15 16:53:22,901 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3e166b683893?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-15 16:53:23,452 unpacking tar archive at: mozilla-central-3e166b683893/testing/mozharness/ program finished with exit code 0 elapsedTime=0.903083 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-15 16:53:22.925859) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-15 16:53:22.926188) ========= script_repo_revision: 3e166b6838931b3933ca274331f9e0e115af5cc0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-15 16:53:22.926582) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-15 16:53:22.926878) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-15 16:53:22.941645) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-05-15 16:53:22.941968) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:53:23 INFO - MultiFileLogger online at 20170515 16:53:23 in /builds/slave/test 16:53:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:53:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:53:23 INFO - {'append_to_log': False, 16:53:23 INFO - 'base_work_dir': '/builds/slave/test', 16:53:23 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:53:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:53:23 INFO - 'branch': 'Firefox-Non-PGO', 16:53:23 INFO - 'buildbot_json_path': 'buildprops.json', 16:53:23 INFO - 'config_files': ('talos/linux_config.py',), 16:53:23 INFO - 'default_actions': ('clobber', 16:53:23 INFO - 'read-buildbot-config', 16:53:23 INFO - 'download-and-extract', 16:53:23 INFO - 'populate-webroot', 16:53:23 INFO - 'create-virtualenv', 16:53:23 INFO - 'install', 16:53:23 INFO - 'run-tests'), 16:53:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:53:23 INFO - 'download_minidump_stackwalk': True, 16:53:23 INFO - 'download_symbols': 'ondemand', 16:53:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:53:23 INFO - 'tooltool.py': '/tools/tooltool.py', 16:53:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:53:23 INFO - '/tools/misc-python/virtualenv.py')}, 16:53:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:53:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:53:23 INFO - 'gecko_profile': False, 16:53:23 INFO - 'gecko_profile_interval': 0, 16:53:23 INFO - 'installer_path': 'installer.exe', 16:53:23 INFO - 'log_level': 'info', 16:53:23 INFO - 'log_name': 'talos', 16:53:23 INFO - 'log_to_console': True, 16:53:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:53:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:53:23 INFO - 'opt_config_files': (), 16:53:23 INFO - 'pip_index': False, 16:53:23 INFO - 'suite': 'dromaeojs-e10s', 16:53:23 INFO - 'system_bits': '32', 16:53:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:53:23 INFO - 'title': 'talos-linux64-ix-041', 16:53:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:53:23 INFO - 'use_talos_json': True, 16:53:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:53:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:53:23 INFO - 'work_dir': 'build'} 16:53:23 INFO - [mozharness: 2017-05-15 23:53:23.944727Z] Running clobber step. 16:53:23 INFO - Running pre-action listener: _resource_record_pre_action 16:53:23 INFO - Running main action method: clobber 16:53:23 INFO - rmtree: /builds/slave/test/build 16:53:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:53:25 INFO - Running post-action listener: _resource_record_post_action 16:53:25 INFO - [mozharness: 2017-05-15 23:53:25.467215Z] Finished clobber step (success) 16:53:25 INFO - [mozharness: 2017-05-15 23:53:25.467313Z] Running read-buildbot-config step. 16:53:25 INFO - Running pre-action listener: _resource_record_pre_action 16:53:25 INFO - Running main action method: read_buildbot_config 16:53:25 INFO - Using buildbot properties: 16:53:25 INFO - { 16:53:25 INFO - "project": "", 16:53:25 INFO - "product": "firefox", 16:53:25 INFO - "who": "kwierso@gmail.com", 16:53:25 INFO - "installer_path": "public/build/target.tar.bz2", 16:53:25 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 16:53:25 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 16:53:25 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 16:53:25 INFO - "stage_platform": "linux64", 16:53:25 INFO - "basedir": "/builds/slave/test", 16:53:25 INFO - "buildnumber": 606, 16:53:25 INFO - "platform": "ubuntu64_hw", 16:53:25 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:53:25 INFO - "slavebuilddir": "test", 16:53:25 INFO - "taskId": "Dwni3myRQhinxaNUlw9MXQ", 16:53:25 INFO - "branch": "mozilla-central", 16:53:25 INFO - "script_repo_revision": "production", 16:53:25 INFO - "revision": "3e166b6838931b3933ca274331f9e0e115af5cc0", 16:53:25 INFO - "slavename": "talos-linux64-ix-041", 16:53:25 INFO - "repo_path": "mozilla-central" 16:53:25 INFO - } 16:53:25 INFO - Finding installer, test and symbols from parent task. 16:53:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dwni3myRQhinxaNUlw9MXQ'}, attempt #1 16:53:25 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dwni3myRQhinxaNUlw9MXQ'}, attempt #1 16:53:26 INFO - Task dependencies: WIw5Dk7pTR-0oB3GcXYf6A 16:53:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A'}, attempt #1 16:53:26 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/target.tar.bz2 16:53:26 INFO - Set test_url: https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/test_packages.json 16:53:26 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/target.crashreporter-symbols.zip 16:53:26 INFO - Running post-action listener: _resource_record_post_action 16:53:26 INFO - [mozharness: 2017-05-15 23:53:26.831267Z] Finished read-buildbot-config step (success) 16:53:26 INFO - [mozharness: 2017-05-15 23:53:26.831485Z] Running download-and-extract step. 16:53:26 INFO - Running pre-action listener: _resource_record_pre_action 16:53:26 INFO - Running main action method: download_and_extract 16:53:26 INFO - mkdir: /builds/slave/test/build/tests 16:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:26 INFO - trying https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/target.test_packages.json 16:53:26 INFO - Downloading https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 16:53:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 16:53:27 INFO - Downloaded 986 bytes. 16:53:27 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 16:53:27 INFO - Using the following test package requirements: 16:53:27 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 16:53:27 INFO - u'common': [u'target.common.tests.zip'], 16:53:27 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 16:53:27 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 16:53:27 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 16:53:27 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 16:53:27 INFO - u'mozbase': [u'target.common.tests.zip'], 16:53:27 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 16:53:27 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 16:53:27 INFO - u'web-platform': [u'target.common.tests.zip', 16:53:27 INFO - u'target.web-platform.tests.zip'], 16:53:27 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 16:53:27 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 16:53:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/target.common.tests.zip 16:53:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:53:27 INFO - Fetch https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/target.common.tests.zip into memory 16:53:29 INFO - Content-Length response header: 62449499 16:53:29 INFO - Bytes received: 62449499 16:53:39 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 16:53:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/target.common.tests.zip 16:53:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/target.common.tests.zip'}, attempt #1 16:53:39 INFO - Fetch https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/target.common.tests.zip into memory 16:53:41 INFO - Content-Length response header: 62449499 16:53:41 INFO - Bytes received: 62449499 16:53:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/target.talos.tests.zip 16:53:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/target.talos.tests.zip'}, attempt #1 16:53:52 INFO - Fetch https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/target.talos.tests.zip into memory 16:53:54 INFO - Content-Length response header: 14410013 16:53:54 INFO - Bytes received: 14410013 16:53: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')]} 16:53:54 INFO - trying https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/target.tar.bz2 16:53:54 INFO - Downloading https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 16:53:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 16:53:56 INFO - Downloaded 63368508 bytes. 16:53:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/target.tar.bz2 16:53:56 INFO - mkdir: /builds/slave/test/properties 16:53:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:53:56 INFO - Writing to file /builds/slave/test/properties/build_url 16:53:56 INFO - Contents: 16:53:56 INFO - build_url:https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/target.tar.bz2 16:53:56 INFO - Running post-action listener: _resource_record_post_action 16:53:56 INFO - Running post-action listener: set_extra_try_arguments 16:53:56 INFO - [mozharness: 2017-05-15 23:53:56.707216Z] Finished download-and-extract step (success) 16:53:56 INFO - [mozharness: 2017-05-15 23:53:56.707380Z] Running populate-webroot step. 16:53:56 INFO - Running pre-action listener: _resource_record_pre_action 16:53:56 INFO - Running main action method: populate_webroot 16:53:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:53:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:53:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:53:56 INFO - '--tppagecycles', 16:53:56 INFO - '7'], 16:53:56 INFO - 'tests': ['tsvgm']}}, 16:53:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:53:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:53:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:53:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:53:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:53:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:53:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:53:56 INFO - 'talos_options': ['--disable-e10s'], 16:53:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:53:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:53:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:53:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:53:56 INFO - 'talos_options': ['--disable-e10s'], 16:53:56 INFO - 'tests': ['damp', 'tps']}, 16:53:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:53:56 INFO - 'tests': ['damp', 'tps']}, 16:53:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:53:56 INFO - 'tests': ['dromaeo_dom']}, 16:53:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:53:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:53:56 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 16:53:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 16:53:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:53:56 INFO - 'tests': ['a11yr', 16:53:56 INFO - 'ts_paint', 16:53:56 INFO - 'tpaint', 16:53:56 INFO - 'sessionrestore', 16:53:56 INFO - 'sessionrestore_no_auto_restore', 16:53:56 INFO - 'tabpaint']}, 16:53:56 INFO - 'other-e10s': {'tests': ['a11yr', 16:53:56 INFO - 'ts_paint', 16:53:56 INFO - 'tpaint', 16:53:56 INFO - 'sessionrestore', 16:53:56 INFO - 'sessionrestore_no_auto_restore', 16:53:56 INFO - 'tabpaint']}, 16:53:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:53:56 INFO - 'ts_paint', 16:53:56 INFO - 'tpaint', 16:53:56 INFO - 'sessionrestore', 16:53:56 INFO - 'sessionrestore_no_auto_restore', 16:53:56 INFO - 'tabpaint']}, 16:53:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:53:56 INFO - 'ts_paint', 16:53:56 INFO - 'tpaint', 16:53:56 INFO - 'sessionrestore', 16:53:56 INFO - 'sessionrestore_no_auto_restore', 16:53:56 INFO - 'tabpaint']}, 16:53:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:53:56 INFO - 'tests': ['a11yr', 16:53:56 INFO - 'ts_paint', 16:53:56 INFO - 'tpaint', 16:53:56 INFO - 'sessionrestore', 16:53:56 INFO - 'sessionrestore_no_auto_restore', 16:53:56 INFO - 'tabpaint']}, 16:53:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:53:56 INFO - 'tests': ['a11yr', 16:53:56 INFO - 'ts_paint', 16:53:56 INFO - 'tpaint', 16:53:56 INFO - 'sessionrestore', 16:53:56 INFO - 'sessionrestore_no_auto_restore', 16:53:56 INFO - 'tabpaint']}, 16:53:56 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 16:53:56 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 16:53:56 INFO - 'bloom_basic_ref']}, 16:53:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:53:56 INFO - 'tests': ['tsvgx', 16:53:56 INFO - 'tsvgr_opacity', 16:53:56 INFO - 'tart', 16:53:56 INFO - 'tscrollx', 16:53:56 INFO - 'cart', 16:53:56 INFO - 'tsvg_static']}, 16:53:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:53:56 INFO - 'tsvgr_opacity', 16:53:56 INFO - 'tart', 16:53:56 INFO - 'tscrollx', 16:53:56 INFO - 'cart', 16:53:56 INFO - 'tsvg_static']}, 16:53:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:53:56 INFO - 'talos_options': ['--disable-e10s'], 16:53:56 INFO - 'tests': ['tp5o']}, 16:53:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:53:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:53:56 INFO - 'talos_options': ['--disable-e10s', 16:53:56 INFO - '--xperf_path', 16:53:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:53:56 INFO - 'tests': ['tp5n']}, 16:53:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:53:56 INFO - 'talos_options': ['--xperf_path', 16:53:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:53:56 INFO - 'tests': ['tp5n']}}, 16:53:56 INFO - 'talos.zip': {'path': '', 16:53:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:53:56 INFO - Running post-action listener: _resource_record_post_action 16:53:56 INFO - [mozharness: 2017-05-15 23:53:56.728204Z] Finished populate-webroot step (success) 16:53:56 INFO - [mozharness: 2017-05-15 23:53:56.728293Z] Running create-virtualenv step. 16:53:56 INFO - Running pre-action listener: _resource_record_pre_action 16:53:56 INFO - Running main action method: create_virtualenv 16:53:56 INFO - Creating virtualenv /builds/slave/test/build/venv 16:53:56 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 16:53:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:53:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:53:56 INFO - Using real prefix '/usr' 16:53:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:53:57 INFO - Installing distribute.............................................................................................................................................................................................done. 16:53:59 INFO - Installing pip.................done. 16:53:59 INFO - Return code: 0 16:53:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:53:59 INFO - Reading from file tmpfile_stdout 16:53:59 INFO - Output received: 16:53:59 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) 16:53:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:59 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 0x13e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17577a0>, '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 0x17586a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1758b30>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772', '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 16:53:59 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 16:53:59 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 16:53:59 INFO - Using env: {'DISPLAY': ':0', 16:53:59 INFO - 'HOME': '/home/cltbld', 16:53:59 INFO - 'LANG': 'en_US.UTF-8', 16:53:59 INFO - 'LANGUAGE': 'en_US:en', 16:53:59 INFO - 'LOGNAME': 'cltbld', 16:53:59 INFO - 'MAIL': '/var/mail/cltbld', 16:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:59 INFO - 'MOZ_NO_REMOTE': '1', 16:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:59 INFO - 'NO_EM_RESTART': '1', 16:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:59 INFO - 'PWD': '/builds/slave/test', 16:53:59 INFO - 'SHELL': '/bin/bash', 16:53:59 INFO - 'SHLVL': '1', 16:53:59 INFO - 'TERM': 'linux', 16:53:59 INFO - 'TMOUT': '86400', 16:53:59 INFO - 'USER': 'cltbld', 16:53:59 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772', 16:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:59 INFO - '_': '/tools/buildbot/bin/python'} 16:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:59 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 16:53:59 INFO - Cleaning up... 16:53:59 INFO - Return code: 0 16:53:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:53:59 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 0x13e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17577a0>, '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 0x17586a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1758b30>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772', '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 16:53:59 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 16:53:59 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 16:53:59 INFO - Using env: {'DISPLAY': ':0', 16:53:59 INFO - 'HOME': '/home/cltbld', 16:53:59 INFO - 'LANG': 'en_US.UTF-8', 16:53:59 INFO - 'LANGUAGE': 'en_US:en', 16:53:59 INFO - 'LOGNAME': 'cltbld', 16:53:59 INFO - 'MAIL': '/var/mail/cltbld', 16:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:53:59 INFO - 'MOZ_NO_REMOTE': '1', 16:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:53:59 INFO - 'NO_EM_RESTART': '1', 16:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:53:59 INFO - 'PWD': '/builds/slave/test', 16:53:59 INFO - 'SHELL': '/bin/bash', 16:53:59 INFO - 'SHLVL': '1', 16:53:59 INFO - 'TERM': 'linux', 16:53:59 INFO - 'TMOUT': '86400', 16:53:59 INFO - 'USER': 'cltbld', 16:53:59 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772', 16:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:53:59 INFO - '_': '/tools/buildbot/bin/python'} 16:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:53:59 INFO - Downloading/unpacking psutil>=3.1.1 16:53:59 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 16:53:59 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 16:53:59 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 16:53:59 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 16:54:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:54:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:54:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:54:01 INFO - Installing collected packages: psutil 16:54:01 INFO - Running setup.py install for psutil 16:54:01 INFO - building 'psutil._psutil_linux' extension 16:54:01 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 16:54:01 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 16:54:01 INFO - building 'psutil._psutil_posix' extension 16:54:01 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 16:54:01 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 16:54:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:54:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:54:01 INFO - Successfully installed psutil 16:54:01 INFO - Cleaning up... 16:54:01 INFO - Return code: 0 16:54:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:54: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')]} 16:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54: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')]} 16:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17577a0>, '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 0x17586a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1758b30>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772', '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 16:54: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:54: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 mozsystemmonitor==0.3 16:54:01 INFO - Using env: {'DISPLAY': ':0', 16:54:01 INFO - 'HOME': '/home/cltbld', 16:54:01 INFO - 'LANG': 'en_US.UTF-8', 16:54:01 INFO - 'LANGUAGE': 'en_US:en', 16:54:01 INFO - 'LOGNAME': 'cltbld', 16:54:01 INFO - 'MAIL': '/var/mail/cltbld', 16:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:01 INFO - 'MOZ_NO_REMOTE': '1', 16:54:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:01 INFO - 'NO_EM_RESTART': '1', 16:54:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:01 INFO - 'PWD': '/builds/slave/test', 16:54:01 INFO - 'SHELL': '/bin/bash', 16:54:01 INFO - 'SHLVL': '1', 16:54:01 INFO - 'TERM': 'linux', 16:54:01 INFO - 'TMOUT': '86400', 16:54:01 INFO - 'USER': 'cltbld', 16:54:01 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772', 16:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:01 INFO - '_': '/tools/buildbot/bin/python'} 16:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:01 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:54: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 16:54: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 16:54: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 16:54: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 16:54:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:54:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:54:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:54:03 INFO - Installing collected packages: mozsystemmonitor 16:54:03 INFO - Running setup.py install for mozsystemmonitor 16:54:03 INFO - Successfully installed mozsystemmonitor 16:54:03 INFO - Cleaning up... 16:54:03 INFO - Return code: 0 16:54:03 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:54: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')]} 16:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54: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')]} 16:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54: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', '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 0x13e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17577a0>, '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 0x17586a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1758b30>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772', '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 16:54: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:54: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 jsonschema==2.5.1 16:54:03 INFO - Using env: {'DISPLAY': ':0', 16:54:03 INFO - 'HOME': '/home/cltbld', 16:54:03 INFO - 'LANG': 'en_US.UTF-8', 16:54:03 INFO - 'LANGUAGE': 'en_US:en', 16:54:03 INFO - 'LOGNAME': 'cltbld', 16:54:03 INFO - 'MAIL': '/var/mail/cltbld', 16:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:03 INFO - 'MOZ_NO_REMOTE': '1', 16:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:03 INFO - 'NO_EM_RESTART': '1', 16:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:03 INFO - 'PWD': '/builds/slave/test', 16:54:03 INFO - 'SHELL': '/bin/bash', 16:54:03 INFO - 'SHLVL': '1', 16:54:03 INFO - 'TERM': 'linux', 16:54:03 INFO - 'TMOUT': '86400', 16:54:03 INFO - 'USER': 'cltbld', 16:54:03 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772', 16:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:03 INFO - '_': '/tools/buildbot/bin/python'} 16:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:03 INFO - Downloading/unpacking jsonschema==2.5.1 16:54: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 16:54: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 16:54: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 16:54: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 16:54:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:54:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:54:04 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 16:54:04 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 16:54:04 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 16:54:04 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 16:54:04 INFO - Downloading functools32-3.2.3-2.tar.gz 16:54:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:54:04 INFO - warning: no files found matching '*.txt' 16:54:04 INFO - no previously-included directories found matching 'build' 16:54:04 INFO - no previously-included directories found matching 'dist' 16:54:04 INFO - no previously-included directories found matching '.git*' 16:54:04 INFO - Installing collected packages: jsonschema, functools32 16:54:04 INFO - Running setup.py install for functools32 16:54:04 INFO - warning: no files found matching '*.txt' 16:54:04 INFO - no previously-included directories found matching 'build' 16:54:04 INFO - no previously-included directories found matching 'dist' 16:54:04 INFO - no previously-included directories found matching '.git*' 16:54:04 INFO - Successfully installed jsonschema functools32 16:54:04 INFO - Cleaning up... 16:54:04 INFO - Return code: 0 16:54:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17577a0>, '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 0x17586a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1758b30>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772', '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 16:54:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:54:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:54:04 INFO - Using env: {'DISPLAY': ':0', 16:54:04 INFO - 'HOME': '/home/cltbld', 16:54:04 INFO - 'LANG': 'en_US.UTF-8', 16:54:04 INFO - 'LANGUAGE': 'en_US:en', 16:54:04 INFO - 'LOGNAME': 'cltbld', 16:54:04 INFO - 'MAIL': '/var/mail/cltbld', 16:54:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:04 INFO - 'MOZ_NO_REMOTE': '1', 16:54:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:04 INFO - 'NO_EM_RESTART': '1', 16:54:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:04 INFO - 'PWD': '/builds/slave/test', 16:54:04 INFO - 'SHELL': '/bin/bash', 16:54:04 INFO - 'SHLVL': '1', 16:54:04 INFO - 'TERM': 'linux', 16:54:04 INFO - 'TMOUT': '86400', 16:54:04 INFO - 'USER': 'cltbld', 16:54:04 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772', 16:54:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:04 INFO - '_': '/tools/buildbot/bin/python'} 16:54:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:54:05 INFO - Cleaning up... 16:54:05 INFO - Return code: 0 16:54:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x13e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17577a0>, '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 0x17586a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1758b30>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772', '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 16:54:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:54:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:54:05 INFO - Using env: {'DISPLAY': ':0', 16:54:05 INFO - 'HOME': '/home/cltbld', 16:54:05 INFO - 'LANG': 'en_US.UTF-8', 16:54:05 INFO - 'LANGUAGE': 'en_US:en', 16:54:05 INFO - 'LOGNAME': 'cltbld', 16:54:05 INFO - 'MAIL': '/var/mail/cltbld', 16:54:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:05 INFO - 'MOZ_NO_REMOTE': '1', 16:54:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:05 INFO - 'NO_EM_RESTART': '1', 16:54:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:05 INFO - 'PWD': '/builds/slave/test', 16:54:05 INFO - 'SHELL': '/bin/bash', 16:54:05 INFO - 'SHLVL': '1', 16:54:05 INFO - 'TERM': 'linux', 16:54:05 INFO - 'TMOUT': '86400', 16:54:05 INFO - 'USER': 'cltbld', 16:54:05 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772', 16:54:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:05 INFO - '_': '/tools/buildbot/bin/python'} 16:54:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:05 INFO - Downloading/unpacking blobuploader==1.2.4 16:54: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 16:54: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 16:54: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 16:54: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 16:54:06 INFO - Downloading blobuploader-1.2.4.tar.gz 16:54:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:54:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:54:06 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 16:54:06 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 16:54:06 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 16:54:06 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 16:54:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:54:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:54:06 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 16:54:06 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 16:54:06 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 16:54:06 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 16:54:06 INFO - Downloading docopt-0.6.1.tar.gz 16:54:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:54:06 INFO - Installing collected packages: blobuploader, requests, docopt 16:54:06 INFO - Running setup.py install for blobuploader 16:54:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:54:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:54:07 INFO - Running setup.py install for requests 16:54:07 INFO - Running setup.py install for docopt 16:54:07 INFO - Successfully installed blobuploader requests docopt 16:54:07 INFO - Cleaning up... 16:54:07 INFO - Return code: 0 16:54:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:07 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 0x13e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17577a0>, '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 0x17586a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1758b30>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772', '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 16:54:07 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 16:54:07 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 16:54:07 INFO - Using env: {'DISPLAY': ':0', 16:54:07 INFO - 'HOME': '/home/cltbld', 16:54:07 INFO - 'LANG': 'en_US.UTF-8', 16:54:07 INFO - 'LANGUAGE': 'en_US:en', 16:54:07 INFO - 'LOGNAME': 'cltbld', 16:54:07 INFO - 'MAIL': '/var/mail/cltbld', 16:54:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:07 INFO - 'MOZ_NO_REMOTE': '1', 16:54:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:07 INFO - 'NO_EM_RESTART': '1', 16:54:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:07 INFO - 'PWD': '/builds/slave/test', 16:54:07 INFO - 'SHELL': '/bin/bash', 16:54:07 INFO - 'SHLVL': '1', 16:54:07 INFO - 'TERM': 'linux', 16:54:07 INFO - 'TMOUT': '86400', 16:54:07 INFO - 'USER': 'cltbld', 16:54:07 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772', 16:54:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:07 INFO - '_': '/tools/buildbot/bin/python'} 16:54:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:54:07 INFO - Running setup.py (path:/tmp/pip-r7uXew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:54:07 INFO - Running setup.py (path:/tmp/pip-5VtSNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:54:07 INFO - Running setup.py (path:/tmp/pip-BTmm1B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:54:08 INFO - Running setup.py (path:/tmp/pip-RITWay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:54:08 INFO - Running setup.py (path:/tmp/pip-dwEmZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:54:08 INFO - Running setup.py (path:/tmp/pip-g6d5ja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:54:08 INFO - Running setup.py (path:/tmp/pip-HhoFkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:54:08 INFO - Running setup.py (path:/tmp/pip-Dzxgmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:54:08 INFO - Running setup.py (path:/tmp/pip-6esvll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:54:08 INFO - Running setup.py (path:/tmp/pip-OUIInm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:54:08 INFO - Running setup.py (path:/tmp/pip-Z_6zko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:54:08 INFO - Running setup.py (path:/tmp/pip-6ZlljR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:54:08 INFO - Running setup.py (path:/tmp/pip-oM0FjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:54:08 INFO - Running setup.py (path:/tmp/pip-8AoWdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:08 INFO - Running setup.py (path:/tmp/pip-pOKQr8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:54:08 INFO - Running setup.py (path:/tmp/pip-T55n0o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:54:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:54:08 INFO - Running setup.py (path:/tmp/pip-G0Bf6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:54:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:54:09 INFO - Running setup.py install for manifestparser 16:54:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:54:09 INFO - Running setup.py install for mozcrash 16:54:09 INFO - Running setup.py install for mozdebug 16:54:09 INFO - Running setup.py install for mozdevice 16:54:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:54:09 INFO - Running setup.py install for mozfile 16:54:09 INFO - Running setup.py install for mozhttpd 16:54:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:54:09 INFO - Running setup.py install for mozinfo 16:54:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:54:09 INFO - Running setup.py install for mozInstall 16:54:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:54:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:54:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:54:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:54:09 INFO - Running setup.py install for mozleak 16:54:09 INFO - Running setup.py install for mozlog 16:54:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:54:10 INFO - Running setup.py install for moznetwork 16:54:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:54:10 INFO - Running setup.py install for mozprocess 16:54:10 INFO - Running setup.py install for mozprofile 16:54:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:54:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:54:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:54:10 INFO - Running setup.py install for mozrunner 16:54:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:54:10 INFO - Running setup.py install for mozscreenshot 16:54:10 INFO - Running setup.py install for moztest 16:54:10 INFO - Running setup.py install for mozversion 16:54:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:54:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:54:10 INFO - Cleaning up... 16:54:10 INFO - Return code: 0 16:54:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:10 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 0x13e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17577a0>, '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 0x17586a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1758b30>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772', '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 16:54:10 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 16:54:10 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 16:54:10 INFO - Using env: {'DISPLAY': ':0', 16:54:10 INFO - 'HOME': '/home/cltbld', 16:54:10 INFO - 'LANG': 'en_US.UTF-8', 16:54:10 INFO - 'LANGUAGE': 'en_US:en', 16:54:10 INFO - 'LOGNAME': 'cltbld', 16:54:10 INFO - 'MAIL': '/var/mail/cltbld', 16:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:10 INFO - 'MOZ_NO_REMOTE': '1', 16:54:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:10 INFO - 'NO_EM_RESTART': '1', 16:54:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:10 INFO - 'PWD': '/builds/slave/test', 16:54:10 INFO - 'SHELL': '/bin/bash', 16:54:10 INFO - 'SHLVL': '1', 16:54:10 INFO - 'TERM': 'linux', 16:54:10 INFO - 'TMOUT': '86400', 16:54:10 INFO - 'USER': 'cltbld', 16:54:10 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772', 16:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:10 INFO - '_': '/tools/buildbot/bin/python'} 16:54:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:54:11 INFO - Running setup.py (path:/tmp/pip-1JZXUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:54:11 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)) 16:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:54:11 INFO - Running setup.py (path:/tmp/pip-SqkvwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:54:11 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)) 16:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:54:11 INFO - Running setup.py (path:/tmp/pip-FzwYQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:54:11 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)) 16:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:54:11 INFO - Running setup.py (path:/tmp/pip-aCIhK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:54:11 INFO - Running setup.py (path:/tmp/pip-M6gxZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:54:11 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)) 16:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:54:11 INFO - Running setup.py (path:/tmp/pip-2jGXz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:54:11 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)) 16:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:54:11 INFO - Running setup.py (path:/tmp/pip-MYsNc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:54:11 INFO - Running setup.py (path:/tmp/pip-8nXc4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:54:11 INFO - Running setup.py (path:/tmp/pip-TYB3Tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:54:11 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)) 16:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:54:11 INFO - Running setup.py (path:/tmp/pip-TFOxPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:54:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:54:11 INFO - Running setup.py (path:/tmp/pip-oFtdI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:54:11 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)) 16:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:54:11 INFO - Running setup.py (path:/tmp/pip-1ve7Ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:54:11 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)) 16:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:54:11 INFO - Running setup.py (path:/tmp/pip-D8CBia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:54:11 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)) 16:54:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:54:11 INFO - Running setup.py (path:/tmp/pip-4xESKP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:54:12 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)) 16:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:12 INFO - Running setup.py (path:/tmp/pip-ws5lGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:54:12 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)) 16:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:54:12 INFO - Running setup.py (path:/tmp/pip-H2m8L3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:54:12 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)) 16:54:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:54:12 INFO - Running setup.py (path:/tmp/pip-jviuHx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:54:12 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)) 16:54:12 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)) 16:54:12 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)) 16:54:12 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)) 16:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:54:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:54:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:54: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 16:54: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 16:54: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 16:54: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 16:54:13 INFO - Downloading blessings-1.6.tar.gz 16:54:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:54:13 INFO - Installing collected packages: blessings 16:54:13 INFO - Running setup.py install for blessings 16:54:13 INFO - Successfully installed blessings 16:54:13 INFO - Cleaning up... 16:54:13 INFO - Return code: 0 16:54:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:54:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:54:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:54:13 INFO - Reading from file tmpfile_stdout 16:54:13 INFO - Current package versions: 16:54:13 INFO - argparse == 1.2.1 16:54:13 INFO - blessings == 1.6 16:54:13 INFO - blobuploader == 1.2.4 16:54:13 INFO - docopt == 0.6.1 16:54:13 INFO - functools32 == 3.2.3-2 16:54:13 INFO - jsonschema == 2.5.1 16:54:13 INFO - manifestparser == 1.1 16:54:13 INFO - mozInstall == 1.12 16:54:13 INFO - mozcrash == 1.0 16:54:13 INFO - mozdebug == 0.1 16:54:13 INFO - mozdevice == 0.50 16:54:13 INFO - mozfile == 1.2 16:54:13 INFO - mozhttpd == 0.7 16:54:13 INFO - mozinfo == 0.9 16:54:13 INFO - mozleak == 0.1 16:54:13 INFO - mozlog == 3.4 16:54:13 INFO - moznetwork == 0.27 16:54:13 INFO - mozprocess == 0.25 16:54:13 INFO - mozprofile == 0.28 16:54:13 INFO - mozrunner == 6.13 16:54:13 INFO - mozscreenshot == 0.1 16:54:13 INFO - mozsystemmonitor == 0.3 16:54:13 INFO - moztest == 0.8 16:54:13 INFO - mozversion == 1.4 16:54:13 INFO - psutil == 3.1.1 16:54:13 INFO - requests == 1.2.3 16:54:13 INFO - wsgiref == 0.1.2 16:54:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:13 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 0x13e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17577a0>, '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 0x17586a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1758b30>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772', '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 16:54:13 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 16:54:13 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 16:54:13 INFO - Using env: {'DISPLAY': ':0', 16:54:13 INFO - 'HOME': '/home/cltbld', 16:54:13 INFO - 'LANG': 'en_US.UTF-8', 16:54:13 INFO - 'LANGUAGE': 'en_US:en', 16:54:13 INFO - 'LOGNAME': 'cltbld', 16:54:13 INFO - 'MAIL': '/var/mail/cltbld', 16:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:13 INFO - 'MOZ_NO_REMOTE': '1', 16:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:13 INFO - 'NO_EM_RESTART': '1', 16:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:13 INFO - 'PWD': '/builds/slave/test', 16:54:13 INFO - 'SHELL': '/bin/bash', 16:54:13 INFO - 'SHLVL': '1', 16:54:13 INFO - 'TERM': 'linux', 16:54:13 INFO - 'TMOUT': '86400', 16:54:13 INFO - 'USER': 'cltbld', 16:54:13 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772', 16:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:13 INFO - '_': '/tools/buildbot/bin/python'} 16:54:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:14 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)) 16:54:14 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)) 16:54:14 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)) 16:54:14 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)) 16:54:14 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)) 16:54:14 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)) 16:54:14 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)) 16:54:14 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)) 16:54:14 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)) 16:54: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)) 16:54: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)) 16:54:14 INFO - Cleaning up... 16:54:14 INFO - Return code: 0 16:54:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:54:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:54:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:54:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x13e71f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x175a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17577a0>, '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 0x17586a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1758b30>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772', '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 16:54:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:54:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:54:14 INFO - Using env: {'DISPLAY': ':0', 16:54:14 INFO - 'HOME': '/home/cltbld', 16:54:14 INFO - 'LANG': 'en_US.UTF-8', 16:54:14 INFO - 'LANGUAGE': 'en_US:en', 16:54:14 INFO - 'LOGNAME': 'cltbld', 16:54:14 INFO - 'MAIL': '/var/mail/cltbld', 16:54:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:14 INFO - 'MOZ_NO_REMOTE': '1', 16:54:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:14 INFO - 'NO_EM_RESTART': '1', 16:54:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:14 INFO - 'PWD': '/builds/slave/test', 16:54:14 INFO - 'SHELL': '/bin/bash', 16:54:14 INFO - 'SHLVL': '1', 16:54:14 INFO - 'TERM': 'linux', 16:54:14 INFO - 'TMOUT': '86400', 16:54:14 INFO - 'USER': 'cltbld', 16:54:14 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772', 16:54:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:14 INFO - '_': '/tools/buildbot/bin/python'} 16:54:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:54:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:54:14 INFO - Cleaning up... 16:54:14 INFO - Return code: 0 16:54:14 INFO - Running post-action listener: _resource_record_post_action 16:54:14 INFO - Running post-action listener: _start_resource_monitoring 16:54:14 INFO - Starting resource monitoring. 16:54:14 INFO - [mozharness: 2017-05-15 23:54:14.305717Z] Finished create-virtualenv step (success) 16:54:14 INFO - [mozharness: 2017-05-15 23:54:14.306188Z] Running install step. 16:54:14 INFO - Running pre-action listener: _resource_record_pre_action 16:54:14 INFO - Running main action method: install 16:54:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:54:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:54:14 INFO - Reading from file tmpfile_stdout 16:54:14 INFO - Detecting whether we're running mozinstall >=1.0... 16:54:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:54:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:54:14 INFO - Reading from file tmpfile_stdout 16:54:14 INFO - Output received: 16:54:14 INFO - Usage: mozinstall [options] installer 16:54:14 INFO - Options: 16:54:14 INFO - -h, --help show this help message and exit 16:54:14 INFO - -d DEST, --destination=DEST 16:54:14 INFO - Directory to install application into. [default: 16:54:14 INFO - "/builds/slave/test"] 16:54:14 INFO - --app=APP Application being installed. [default: firefox] 16:54:14 INFO - mkdir: /builds/slave/test/build/application 16:54:14 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'] 16:54:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 16:54:30 INFO - Reading from file tmpfile_stdout 16:54:30 INFO - Output received: 16:54:30 INFO - /builds/slave/test/build/application/firefox/firefox 16:54:30 INFO - Running post-action listener: _resource_record_post_action 16:54:30 INFO - [mozharness: 2017-05-15 23:54:30.480272Z] Finished install step (success) 16:54:30 INFO - [mozharness: 2017-05-15 23:54:30.480547Z] Running run-tests step. 16:54:30 INFO - Running pre-action listener: _resource_record_pre_action 16:54:30 INFO - Running main action method: run_tests 16:54:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:54:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:54:30 INFO - Python 2.7.3 16:54:30 INFO - Return code: 0 16:54:30 INFO - grabbing minidump binary from tooltool 16:54:30 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')]} 16:54:30 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 0x17577a0>, '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 0x17586a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1758b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:54:30 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 16:54:30 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 16:54:30 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 16:54:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:54:30 INFO - Return code: 0 16:54:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:54:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:54:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:54:30 INFO - ENV: RUST_BACKTRACE is now 1 16:54:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:54:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:54:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 16:54:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 16:54:30 INFO - Using env: {'DISPLAY': ':0', 16:54:30 INFO - 'HOME': '/home/cltbld', 16:54:30 INFO - 'LANG': 'en_US.UTF-8', 16:54:30 INFO - 'LANGUAGE': 'en_US:en', 16:54:30 INFO - 'LOGNAME': 'cltbld', 16:54:30 INFO - 'MAIL': '/var/mail/cltbld', 16:54:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:54:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:54:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:54:30 INFO - 'MOZ_NO_REMOTE': '1', 16:54:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:54:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:54:30 INFO - 'NO_EM_RESTART': '1', 16:54:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:54:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:54:30 INFO - 'PWD': '/builds/slave/test', 16:54:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:54:30 INFO - 'RUST_BACKTRACE': '1', 16:54:30 INFO - 'SHELL': '/bin/bash', 16:54:30 INFO - 'SHLVL': '1', 16:54:30 INFO - 'TERM': 'linux', 16:54:30 INFO - 'TMOUT': '86400', 16:54:30 INFO - 'USER': 'cltbld', 16:54:30 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772', 16:54:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:54:30 INFO - '_': '/tools/buildbot/bin/python'} 16:54:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 16:54:30 INFO - mozversion application_buildid: 20170515232230 16:54:30 INFO - mozversion application_changeset: 3e166b6838931b3933ca274331f9e0e115af5cc0 16:54:30 INFO - mozversion application_display_name: Nightly 16:54:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:54:30 INFO - mozversion application_name: Firefox 16:54:30 INFO - mozversion application_remotingname: firefox 16:54:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:54:30 INFO - mozversion application_vendor: Mozilla 16:54:30 INFO - mozversion application_version: 55.0a1 16:54:30 INFO - mozversion platform_buildid: 20170515232230 16:54:30 INFO - mozversion platform_changeset: 3e166b6838931b3933ca274331f9e0e115af5cc0 16:54:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:54:30 INFO - mozversion platform_version: 55.0a1 16:54:30 INFO - using testdate: 1494892470 16:54:30 INFO - actual date: 1494892470 16:54:30 INFO - starting webserver on 'localhost:36669' 16:54:30 INFO - SUITE-START | Running 2 tests 16:54:30 INFO - TEST-START | dromaeo_css 16:54:30 INFO - operating with platform_type : linux_ 16:54:30 INFO - Initialising browser for dromaeo_css test... 16:54:30 INFO - TEST-INFO | started process 26624 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplxFxXV/profile http://localhost:36669/getInfo.html) 16:54:31 INFO - PID 26624 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2932: String.localeCompare is deprecated; use String.prototype.localeCompare instead 16:54:34 INFO - PID 26624 | __metrics Screen width/height:1600/1200 16:54:34 INFO - PID 26624 | colorDepth:24 16:54:34 INFO - PID 26624 | Browser inner width/height: 1024/695 16:54:34 INFO - PID 26624 | __metrics 16:54:36 INFO - TEST-INFO | 26624: exit 0 16:54:36 INFO - Browser initialized. 16:54:36 INFO - Running cycle 1/1 for dromaeo_css test... 16:54:36 INFO - TEST-INFO | started process 26798 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplxFxXV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:54:48 INFO - PID 26798 | RSS: Main: 161697792 16:54:48 INFO - PID 26798 | 16:57:53 INFO - PID 26798 | Cycle 1(1): loaded http://localhost:36669/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36669/tests/dromaeo/cssquery-ext.html) 16:57:55 INFO - PID 26798 | RSS: Main: 168402944 16:57:55 INFO - PID 26798 | 17:00:56 INFO - PID 26798 | Cycle 1(1): loaded http://localhost:36669/tests/dromaeo/cssquery-ext.html (next: http://localhost:36669/tests/dromaeo/cssquery-jquery.html) 17:00:57 INFO - PID 26798 | RSS: Main: 167337984 17:00:57 INFO - PID 26798 | 17:03:59 INFO - PID 26798 | Cycle 1(1): loaded http://localhost:36669/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36669/tests/dromaeo/cssquery-mootools.html) 17:04:00 INFO - PID 26798 | RSS: Main: 168878080 17:04:00 INFO - PID 26798 | 17:07:01 INFO - PID 26798 | Cycle 1(1): loaded http://localhost:36669/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36669/tests/dromaeo/cssquery-prototype.html) 17:07:02 INFO - PID 26798 | RSS: Main: 167424000 17:07:02 INFO - PID 26798 | 17:10:05 INFO - PID 26798 | Cycle 1(1): loaded http://localhost:36669/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36669/tests/dromaeo/cssquery-yui.html) 17:10:05 INFO - PID 26798 | RSS: Main: 167981056 17:10:05 INFO - PID 26798 | 17:13:07 INFO - PID 26798 | Cycle 1(1): loaded http://localhost:36669/tests/dromaeo/cssquery-yui.html (next: http://localhost:36669/tests/dromaeo/cssquery-dojo.html) 17:13:08 INFO - PID 26798 | RSS: Main: 174637056 17:13:08 INFO - PID 26798 | 17:13:08 INFO - PID 26798 | __start_tp_report 17:13:08 INFO - PID 26798 | _x_x_mozilla_page_load 17:13:08 INFO - PID 26798 | _x_x_mozilla_page_load_details 17:13:08 INFO - PID 26798 | |i|pagename|runs| 17:13:08 INFO - PID 26798 | |0;dojo.html;2672.394888459162;2701.1086341507303;2710.810243282971;2723.9591406128898;2728.8362698238116;5139.691618502892;5186.507281808227;5195.740212989345;5200.193969934657;5251.238570407293;5139.486051394859;5213.3743950725875;5296.735163241832;5304.6286759926825;5314.707691076999;4612.377329060568;4612.746298953556;4653;4669.649776266793;4692.2257827458425;4655.720656760588;4687.343771871941;4776.355192049064;4794.81468905112;4832.106060378841;4501.077279157797;4711.222648263032;4719.834805781781;4751.0972915146185;4767.404074490689;4631.884202894921;4660.3941487606735;4709.2229782085915;4723.173444647207;4743.051389722069;4623.884402889955;4647.34937108805;4661.394018777537;4663.393758811367;4745.050989802019;5184;5225.059489291926;5229.084910140748;5233.685978841244;5272.024675435018;5499.120140777496;5568.554515638739;5569.832905012856;5573.470520300565;5573.832785016456;5666.093425051972;5673.00722373583;5677.517411020068;5681.829545113612;5689.146628005791;5268.446813084647;5269.710165940834;5309.973450132725;5313.681179129226;5316.6544174628525;5707.258056452718;5710.229119068956;5761.9135712964335;5771.451712087345;5790.855228619234;5428.83713488596;5431.83704488866;5477.589180811455;5530.087535556588;5554.527865131509;5525.778968841281;5556;5607.214989901417;5632.943670563324;5684.118961560965;5570.220169176318;5577.6932268724795;5580.693061881554;5589.944100559023;5607.327120745536;5465.699386533779;5518;5542.307211598551;5584.636998595079;5599.552035837123;4597.862064138081;4659.906801864012;4679.438467383936;4679.461861885927;4704.1767690654;4034.11249525104;4051.8784436466954;4053.8986525336513;4081.959180408158;4087.693422993287;4779.091972525279;4893.779779909913;4895.118878601886;4904.288878112654;4907.1903135982875;5601.887962240814;5663.292088488939;5686.147077938343;5696.401877802854;5743.023685973395;4905.656604037683;4907.263910413395;4907.288443175719;4909.4354149273295;4910.631702622318;4992.775325110379;5030.773615187325;5034.345535080416;5041.722705251246;5071.594272458195;4806.519348065305;4839.322494850724;4848.0788650156355;4850.854474365704;4853.684510506806;5548.250986116823;5608.38307786135;5610.887782244414;5621.775128994795;5741.25363702716;4765.166095933128;4793.0413917216;4826.734529600905;4828.179209534458;4856.587190088882;5518.144687573433;5587.497125258747;5595.160725891149;5596.468335508121;5648.039833228278;5679.602427830012;5679.630823996427;5689.118186681071;5695.715214239189;5697.658140511417;5343.145096784496;5414.566834653139;5416.864578385572;5499.422560631237;5500.119980803052;5432.592555558428;5455.890882182413;5532.751026203911;5543.6396634218645;5552.333719953632;5393.595480338912;5431.456854314695;5440.836774896601;5478.260434841405;5479.479449452296;5456.972715136399;5508.980838544882;5513.917291240715;5516.696581688046;5560.777568897199;5316.840494785162;5361.115415956324;5430.755615997211;5434.918476222781;5482.122860342326 17:13:08 INFO - PID 26798 | |1;ext.html;685.8696847598956;738.700826165403;756.0360540311102;1054.3831858362853;1055.6938487838527;31928.36143277136;32470.18824529388;32625.83687081564;32651.183720407003;32709.18227044319;33672.32655346891;33910;33981.32037359251;34011.48982765261;34369.14077148073;6515.087887695727;6612.371824676648;6679.966600166992;6785.6267905265195;6798.864022719543;6861.1080559527445;6946.513744037894;6947.617881016542;6949.756758513453;6969.05917701109;6910.723571057177;6974.163100427931;7007.964960175192;7037.190723066836;7039.824004399879;6965.442764578846;6985.336393042653;7002.754903578376;7012.614306213156;7017.157941047081;6382.297947225801;6397.456216221627;6397.6801159941815;6409.903851442232;6435.517336199757;32464.18839529007;32474.18814529632;32477.18807029843;32510.349793004243;32524.34951300961;3054.57235986962;3089.1813669377634;3091.211741006029;3098.442280389529;3100.798448100866;24625.87687061571;24628.50742985148;24689.62965555518;24867.87566062176;24884.253472395678;3174.238182836126;3175.523671449278;3191.0267368452614;3207.3264614430996;3219.114743445571;144247.2787636055;145819;152301;154223;154800;38563.614363856;38601.61398386036;38633.42049869254;38645.42031869524;38744.80627596844;39814;39971.80014099911;40059.79970100189;40123.39814902779;40320.34714272112;12059.51761929513;12070.879291207151;12083.093767967262;12098.213616114925;12143.14997950135;9678.370905891095;9695.951520242354;9702.223822094216;9710.320277580502;9761.560729767178;12382.62852114438;12458.75082498345;12518.749625007631;12532.561360352343;12656.493740250471;5045.672031317952;5157.355330583677;5167.354080739908;5224.660397074178;5297.364316282071;867.0722327109931;867.319154463743;887.1704955866286;902.9909700903038;918.7657147427363;20534.486637833874;21084.57830843405;21321.147154113973;21510.354689359032;21520.784792151877;952.5618215620892;955.254901177083;964.6961207219704;975.2636759246724;976.199516396548;10782;10925.180611454172;11026.173037022256;11102.944485277521;11326.32042077478;182785;182789;183727;183921;184183;39919;40235.79882100571;40296;40318;40333.596664032986;1155.4742592120565;1218.9268643881574;1219.6706889139882;1221.9327936963375;1230.3971054183385;19069.237230510626;19693;20578;20642.58714825725;20871.582568348244;29231.85384073066;29489.410211796072;29509.114726558237;29543;29560.260993475335;152965.23517382343;154214;154298;154465;154828;28386.290342741595;28690.42202678873;29365.55951660684;30592;30671.846640766653;36002.63997359993;36285;36563;36955.260894781415;36971.44542831806;25761.227163185133;26803.86598067075;27270.318242044108;27397.58903616487;27635;26950.32624184411;27298.317542061606;27771.166864994084;27999.860000699868;28918;30845.537316939815;30918.22704432407;30952;30967.0709878704;30969.0709278722;26785.464290714466;26850;26938.86530567413;27361.863190684715;28186;21318.407836877097;22267;22282.554348912607;22445.438864027878;22448.663270050634 17:13:08 INFO - PID 26798 | |2;jquery.html;409.7807672895002;410.3741793764511;413.61740390139124;435.44698233243764;436.25182811478317;11606.59376921808;13271.402786874589;16833.747493787603;17495.650086998252;17528.91235543824;17802.465926022207;18073.1867065982;18079.09604519772;18449.262029518803;19066;5476.26070480486;5558.333000040001;5641.18202860585;5662.6602403855695;5668.149777533383;5452.83641490754;5549.500544950954;5560.582956278275;5566.916496252559;5574.498295153436;5414;5422.945770542303;5517.806876759314;5534.723263836812;5536.944630553703;5463.344398672165;5542.806001789938;5551.306086739158;5553.111502159655;5559.8888022239325;4924;5001.349824522788;5003.199488081889;5024.2965984761795;5074.797008119671;22285.66571501429;22451.663225051638;22515.21196758122;22556.436089097904;22789.746563938977;1648.5878530367409;1683.0406668199132;1684.2589260725242;1685.561753943971;1687.4094067076549;14226.368121897482;14444.277786110653;14932.40270389194;15198.924005380013;15274.541763747106;2077.096463038583;2099.769025407204;2128.2231985325398;2130.5951869144815;2138.5295235048266;83323.33353332899;92546.67079962768;93039;94182;95965;11022.338659680445;11091.5563377464;11150.721231969103;11320.26418282809;11552.537898484135;15624.375024998873;15722.13528255957;15748.76376854348;15807.446739364066;15842.60393490149;7225.710971561079;7463.589502577411;7558.319751222416;7685.654145563463;7692.230776922375;6690.719902723918;6707.429868461138;6883.931160688329;6899.310068993061;6910.412614927687;6892.172939247323;7079.327463890922;7088.964555177191;7230;7257.818554536178;2000.2099170827441;2025.908834102469;2042.5302180498568;2067.576146889884;2169.7287839020123;826.7313123234973;856.3277826905849;860.3375400941366;863.6977058029765;886.9733907982771;16861.241244144043;16939.745903811454;16993.490195293914;17290.91354543219;17765.7335139973;856.7301300090452;860.9311255099577;867.4665080975154;872.842888280103;882.9514376709215;9331.113544213289;9381.765455863659;9714.319997600242;9726.805463890683;9799.755006124762;357394;361316;369981;373276;374317;73789.26210737824;75589.00294938151;76226.23773762303;79775;80005.59997200093;1011.2365164300905;1042.3485321673954;1058.0213302694976;1059.2373491086405;1063.3885515828429;14696.11823290606;14860.405583776961;15103.697926041637;15123.092614442729;15510.922445387701;36777;37077.258454831295;37404.62595374011;37579;37877;45541.54458455373;45594.54405455903;45666.77166614146;45882.54117458783;46192.538074618824;8174.836503269782;8331.750047498585;8480.406371553932;8487.915120848713;8679.305655547667;12390.442430090487;12481.625551233477;12498.812517812423;12759.936200319311;12802.807957880454;10801.729956750829;10834.512446939749;10872.782544349227;10970.177236707119;11265.493052812479;9845.064718851698;9898.158656514277;9927.354721943051;10006.549705263425;10188.439635820101;10791.784164316827;10820.56717731282;10846.29499082557;10887.618933337295;11243.156763242627;8219.794505137419;8381.706640267561;8383.748487545383;8649.308055355683;8667.566621668766;10584.312019718695;10625.468726563795;10707.625233116803;10708.250422470664;10836.837447438453 17:13:08 INFO - PID 26798 | |3;mootools.html;1246.981295280571;1300.2848433361648;1306.4512904580076;1313.225197133691;1317.3215793866157;10089.192864570836;10554.894451055487;10557.208209384298;10584.841227381596;10897.346159230452;10556.78886422273;10746.785064298729;10752.623658171946;10767.084797792177;10770.138388928886;2261.6268315727884;2304.6197377432786;2329.1149363241943;2329.406001469623;2343.55472460232;2210.53578748463;2274.442761523429;2275.3628983884455;2279.794818466338;2280.726312842453;2226.065052677879;2255.4699645583273;2283.1095872609694;2283.1894677389537;2294.1855641247366;2175.630142875715;2212.281008672188;2235.418791114306;2240.932772016842;2245.640697488402;2129.361191642501;2240.7423146338056;2277.077783497686;2279.247848210087;2282.3267136194863;10164.542595583216;10187.235957303157;10202.183825293958;10259.589616415335;10298.12465940396;5657.915131272993;5834.2998840139035;5844.4739973402175;5870.7945221917025;5874.618149820248;3227.7399826175497;3457.343104810078;3489.7545282886904;3527.435610302365;3556.2574338574173;1127.3236058364917;1130.6325444230577;1148.1331594646072;1163.8884864953948;1169.05306701572;15105.697886042328;15184.468543601031;15238.314275857501;15260.542183734506;15292.235388230543;4812.278158276286;4945.381827271591;5080.314157588752;5124.769385377667;5140.717260550631;10770.407627580402;10804.297720648132;10819.350838949687;10823.512941917632;10868.565257389615;5381.1121165007335;5568.387477377485;5598.216249725042;5747.885042299215;5753.769849205984;5122.410922743932;5191.5846732261325;5202.297689811827;5224.37307523092;5236.869078273074;4000;4008.6592639625374;4050.432939388488;4072.6334629883454;4093.488313960755;1163.1102206811795;1175.189119507554;1185.040117504824;1198.9040876730014;1201.1171788735273;672.5023482622823;697.891826766852;701.4773993374866;711.5588335232086;717.4188906985358;5217.791288348423;5386.218998245311;5396.64921780083;5405.378381486101;5451.945480545144;549.409384911222;555.5444535480867;559.1724248112815;559.3539461921487;560.9635373700696;3263.8549042715617;3282.5076238564407;3759.755615884959;3767.830447629863;3821.159344944108;12299.262044277371;12971.156874803108;13138.080334376693;13139;13139.934300328438;12548.24710517372;12756.553520626734;13014.089013768946;13057.151285166434;13341.266230357229;7639.159692433939;7682;7718.652660630285;7773.18381569927;7783.260590243918;5596.552275817843;5647.858803529944;5720.11338242573;5721.313442386941;5752.712364381848;11847.76304473923;12072.517099315928;12151.939240303742;12279.754404911673;12445.191062580903;12195.634130976085;12264.754704905674;12371.072169587496;12528.624141275777;12643.304618245716;7305.963470182615;7327.963360183165;7337.3396394322635;7432.3682486987045;7436.851262974818;9429.198518125762;9644.987276336164;9649.083337082966;9650.806983860142;9663.855042174233;7885.172056934169;8135.471194372347;8158.1026087129185;8243.505389676639;8368.497890126611;8011.599420029092;8142.51144931306;8185.099639039582;8199.262066414052;8229.670813167646;7549.9245007549225;7638.465307428427;7679.731209407644;7686;7713.537187768752;5243.58051355883;5264.578833693219;5344.786208551614;5474.808381706621;5555.111182210827;5297.470252974672;5313.574914006947;5320.57435405159;5339.519443250126;5562.777488900399 17:13:08 INFO - PID 26798 | |4;prototype.html;363.40220337544724;387.78477944740655;394.12110992486737;396.92260009298184;405.54376326632536;5288.5504732097725;5425.593080518962;5458.863528411786;5462.426445223254;5514.283143191389;5239.921401178985;5296.788128474866;5302.867428314294;5309.946900531003;5332.093544097503;4048.271311163989;4066.471358723362;4080.8571699990507;4085.428040074392;4098.569650186732;3905.3946638270972;4048.6356227939477;4084.264832330179;4085.836566537335;4088.7751173685438;4001.4197941298494;4005.799710014502;4021.9798901005456;4028.1138149607186;4037.7981100944835;4005.439238506611;4027.416024676435;4029.395590661395;4030.899227519321;4071.3689378146437;3546.2375589248436;3557.3774589446743;3561.928761424757;3562.2163124112913;3564.108972756811;5192.416313024526;5192.55863251624;5217.686938783647;5242.947570524284;5246.606504512177;4740.265258884844;4740.786664600067;4748.264019077049;4749.62003039756;4750.2874568814605;5498.5876059295315;5645.955498232799;5660.462256085665;5661.886762264731;5673.546116310686;3940.4089386591954;3950.3876899080688;3951.486306780129;3959.3467077932105;3988.122613025159;5742.856428589277;5921.348651648315;5942.227510423617;5979.641221526722;6020.1872747179;4026.697997650188;4040.1717647882115;4043.3126368516832;4048.554658987509;4059.89850253746;4105.815238314283;4122.361034039729;4131.793410329472;4135.627793498599;4138.482689663792;4675.649326300473;4704.1767690654;4730.178881130721;4734.55021772931;4752.1683705351425;5633.492985631231;5646.887062258814;5647.689377084218;5658.7170641467765;5662.886742265132;1398.6503374156462;1412.8979396071081;1413.1379858286437;1416.355558221007;1425.8146440962817;883.5228976352826;940.5045976896766;956.933014688965;960.8894977077586;962.2109869906749;4939.827106051271;4963;4971.552560269593;4992.101421744048;5016.573591244712;5840.29916410025;5852.619579727304;5890.352061273256;5901.852453688606;5954.136650185699;4821.710697358169;4934.61978544698;4955.776990035457;4983;4997.950020499821;3101.674324195972;3116.641586217614;3125.1249650098007;3131.890383836555;3136.4631330647817;4999.825006124841;5000.349954505891;5002.924956125588;5026.447090820006;5032.823851165192;5770.42295770428;5897.557683173779;5943.286805583358;5949.405059494016;5961.374055724174;4978.47725988766;4991.176455884738;4991.875203119951;5003.924941125886;5005.424376196784;5673.74468148926;5788.421157884178;5821.359650438364;5885.411458854252;5891.23413956183;5793;5793.246877905845;5800.477956983892;5805.332386775575;5820.970895145497;4822.348982887265;4950.529699678525;4962.032403681392;5000.824971125993;5010.123228434936;4008.398740188995;4037.152198038445;4054.8986275343354;4068.105016896278;4080.755154690728;5718.714064296852;5916.733746981482;5917.201177841109;5944.138099975566;5969.970150149222;5652.7173641318595;5674.375818659862;5684.806190699834;5700.743466544099;5723.5707321950185;5657.971710141587;5679.563863862304;5691.857703557444;5693.544516438592;5739.110437882135;5477.643953143033;5575.578227551949;5630.0991841305195;5632.971835140798;5658.886822263614;5720.456556627114;5775.5090817281;5779.364269930388;5780;5786.855328616818;5434.2120392542065;5560.499555040065;5566.526845218202;5609.691466969192;5613.410591887793 17:13:08 INFO - PID 26798 | |5;yui.html;664.110092476082;678.9830254243643;728.275366010819;763.0576238345642;782.8356045230502;11438.7140321492;12051.75896482072;13124.21254724716;14000;14048.157110573373;14015.299235038257;14123.364448599812;14916.552503424915;14978.251087445638;15024.248787560633;848.3594885861181;866.8916385451819;867.4578388507183;868.8088620503511;872.8167084912176;912.0605776050645;915.7664795477177;915.8855143107112;918.8024574716435;918.9586468608928;952.9475878826662;957.5260246178152;957.9856302155473;958.7075941837737;960.5533426956464;949.2690628216304;951.2770294576103;952.105021279998;955.9856602150974;958.2621381536213;701.2461603775911;701.9052427922268;702.0802748399561;704.9295070492961;706.3854446631464;12961.222326660336;13165.275909824955;13173.736525269442;13207.86792132076;13249.403776830066;14119.78820317696;14151.363188656433;14277.78583321251;14492.492762753252;14546.854531454655;12453.688657783538;12486.12597118202;12536.937315313457;12594.559190428383;12661.240325580495;2955.349823038928;2968.1540760883045;2975.2710585906593;2985.0746268656785;2987.9551806722916;65907.34092659107;65989.3401065988;66124.3387566123;67705.32294677089;67707.66146169238;10886.564537418573;11075.556977720962;11093.667189984313;12122.151449398458;12566.183198092094;21551;22013.339599812032;22340;22722.20472283462;23109.191178309015;6240.5319601030105;6496.447801936888;6528.673566321665;6534.640594767334;6595.967020164869;3116.158637167952;3153.0698443959086;3154.447971605006;3168.2237851726472;3187.0120262718633;3497.8251087445524;3539.4513850353237;3559.483874838186;4034.899127521777;4155.252054630135;796.2197046894076;815.9347252219808;831.2767891934056;831.8752187171973;835.1231207232381;576.6079066235001;585.1953563849706;601.3925934805877;605.2434456928839;614.4684847606877;9305.860412093823;9347.691323214756;9793.559289831976;9855.142008817362;10148.543315550818;617.1668247865346;623.9344868788803;629.3643420145686;637.2703254773259;639.0254861336499;4317.179735850178;4412.161689279027;4453.665975051884;4490.101979604092;4525.683202175816;61183;61248;62767.686161569814;62825;63138;53110.20334694983;54871.17693234605;55037.174442383395;55428.16857747137;57863.710681446326;47890.52109478861;49494.257586136955;49606.50393496091;50627;50970.49029509732;8854.114588541095;10351.896481035394;10557.9472102639;10724.997000839778;10994.670159895217;24844.254672359857;25295.494090118464;25600.615990760525;25842.483150337262;26136.34659133537;42052.36921446119;42256.36615450832;42515.7874210627;43180.352294714976;43313.7834310839;14131.293435327987;14229.715405692035;14248.572542823731;14373.568792936228;14551.92724036373;15044.924775376054;15416.306266217824;15643.139627320606;16338.428155014517;16384.098874562012;13668.83814875707;14041.648958776112;14112.50606228777;14224.217668028357;14350.641233968816;13573.1856088635;13800.171989680652;13927.164370137823;14075.648108797363;14202.786958195842;12435;12903.935480322538;12904.225746455242;13047.739045218852;13144.40850161726;9075.909240907506;9130.817383652156;9476.620935162791;9553.808923821623;9828.5085745711;10404.427756473468;10784.838227426439;10868.836967445337;10981.121510279;11062.944685276843 17:13:08 INFO - PID 26798 | __end_tp_report 17:13:08 INFO - PID 26798 | __start_cc_report 17:13:08 INFO - PID 26798 | _x_x_mozilla_cycle_collect,287 17:13:08 INFO - PID 26798 | __end_cc_report 17:13:08 INFO - PID 26798 | __startTimestamp1494893588009__endTimestamp 17:13:08 INFO - PID 26798 | 17:13:08 INFO - PID 26798 | ------- Summary: start ------- 17:13:08 INFO - PID 26798 | Number of tests: 6 17:13:08 INFO - PID 26798 | 17:13:08 INFO - PID 26798 | [#0] dojo.html Cycles:165 Average:5133.47 Median:5313.68 stddev:600.73 (11.3%) stddev-sans-first:570.71 17:13:08 INFO - PID 26798 | Values: 2672.4 2701.1 2710.8 2724.0 2728.8 5139.7 5186.5 5195.7 5200.2 5251.2 5139.5 5213.4 5296.7 5304.6 5314.7 4612.4 4612.7 4653.0 4669.6 4692.2 4655.7 4687.3 4776.4 4794.8 4832.1 4501.1 4711.2 4719.8 4751.1 4767.4 4631.9 4660.4 4709.2 4723.2 4743.1 4623.9 4647.3 4661.4 4663.4 4745.1 5184.0 5225.1 5229.1 5233.7 5272.0 5499.1 5568.6 5569.8 5573.5 5573.8 5666.1 5673.0 5677.5 5681.8 5689.1 5268.4 5269.7 5310.0 5313.7 5316.7 5707.3 5710.2 5761.9 5771.5 5790.9 5428.8 5431.8 5477.6 5530.1 5554.5 5525.8 5556.0 5607.2 5632.9 5684.1 5570.2 5577.7 5580.7 5589.9 5607.3 5465.7 5518.0 5542.3 5584.6 5599.6 4597.9 4659.9 4679.4 4679.5 4704.2 4034.1 4051.9 4053.9 4082.0 4087.7 4779.1 4893.8 4895.1 4904.3 4907.2 5601.9 5663.3 5686.1 5696.4 5743.0 4905.7 4907.3 4907.3 4909.4 4910.6 4992.8 5030.8 5034.3 5041.7 5071.6 4806.5 4839.3 4848.1 4850.9 4853.7 5548.3 5608.4 5610.9 5621.8 5741.3 4765.2 4793.0 4826.7 4828.2 4856.6 5518.1 5587.5 5595.2 5596.5 5648.0 5679.6 5679.6 5689.1 5695.7 5697.7 5343.1 5414.6 5416.9 5499.4 5500.1 5432.6 5455.9 5532.8 5543.6 5552.3 5393.6 5431.5 5440.8 5478.3 5479.5 5457.0 5509.0 5513.9 5516.7 5560.8 5316.8 5361.1 5430.8 5434.9 5482.1 17:13:08 INFO - PID 26798 | 17:13:08 INFO - PID 26798 | [#1] ext.html Cycles:180 Average:30479.23 Median:3099.62 stddev:42151.41 (1359.9%) stddev-sans-first:42210.29 17:13:08 INFO - PID 26798 | Values: 685.9 738.7 756.0 1054.4 1055.7 31928.4 32470.2 32625.8 32651.2 32709.2 33672.3 33910.0 33981.3 34011.5 34369.1 6515.1 6612.4 6680.0 6785.6 6798.9 6861.1 6946.5 6947.6 6949.8 6969.1 6910.7 6974.2 7008.0 7037.2 7039.8 6965.4 6985.3 7002.8 7012.6 7017.2 6382.3 6397.5 6397.7 6409.9 6435.5 32464.2 32474.2 32477.2 32510.3 32524.3 3054.6 3089.2 3091.2 3098.4 3100.8 24625.9 24628.5 24689.6 24867.9 24884.3 3174.2 3175.5 3191.0 3207.3 3219.1 144247.3 145819.0 152301.0 154223.0 154800.0 38563.6 38601.6 38633.4 38645.4 38744.8 39814.0 39971.8 40059.8 40123.4 40320.3 12059.5 12070.9 12083.1 12098.2 12143.1 9678.4 9696.0 9702.2 9710.3 9761.6 12382.6 12458.8 12518.7 12532.6 12656.5 5045.7 5157.4 5167.4 5224.7 5297.4 867.1 867.3 887.2 903.0 918.8 20534.5 21084.6 21321.1 21510.4 21520.8 952.6 955.3 964.7 975.3 976.2 10782.0 10925.2 11026.2 11102.9 11326.3 182785.0 182789.0 183727.0 183921.0 184183.0 39919.0 40235.8 40296.0 40318.0 40333.6 1155.5 1218.9 1219.7 1221.9 1230.4 19069.2 19693.0 20578.0 20642.6 20871.6 29231.9 29489.4 29509.1 29543.0 29560.3 152965.2 154214.0 154298.0 154465.0 154828.0 28386.3 28690.4 29365.6 30592.0 30671.8 36002.6 36285.0 36563.0 36955.3 36971.4 25761.2 26803.9 27270.3 27397.6 27635.0 26950.3 27298.3 27771.2 27999.9 28918.0 30845.5 30918.2 30952.0 30967.1 30969.1 26785.5 26850.0 26938.9 27361.9 28186.0 21318.4 22267.0 22282.6 22445.4 22448.7 17:13:08 INFO - PID 26798 | 17:13:08 INFO - PID 26798 | [#2] jquery.html Cycles:180 Average:24686.55 Median:37728.00 stddev:61232.72 (162.3%) stddev-sans-first:61377.36 17:13:08 INFO - PID 26798 | Values: 409.8 410.4 413.6 435.4 436.3 11606.6 13271.4 16833.7 17495.7 17528.9 17802.5 18073.2 18079.1 18449.3 19066.0 5476.3 5558.3 5641.2 5662.7 5668.1 5452.8 5549.5 5560.6 5566.9 5574.5 5414.0 5422.9 5517.8 5534.7 5536.9 5463.3 5542.8 5551.3 5553.1 5559.9 4924.0 5001.3 5003.2 5024.3 5074.8 22285.7 22451.7 22515.2 22556.4 22789.7 1648.6 1683.0 1684.3 1685.6 1687.4 14226.4 14444.3 14932.4 15198.9 15274.5 2077.1 2099.8 2128.2 2130.6 2138.5 83323.3 92546.7 93039.0 94182.0 95965.0 11022.3 11091.6 11150.7 11320.3 11552.5 15624.4 15722.1 15748.8 15807.4 15842.6 7225.7 7463.6 7558.3 7685.7 7692.2 6690.7 6707.4 6883.9 6899.3 6910.4 6892.2 7079.3 7089.0 7230.0 7257.8 2000.2 2025.9 2042.5 2067.6 2169.7 826.7 856.3 860.3 863.7 887.0 16861.2 16939.7 16993.5 17290.9 17765.7 856.7 860.9 867.5 872.8 883.0 9331.1 9381.8 9714.3 9726.8 9799.8 357394.0 361316.0 369981.0 373276.0 374317.0 73789.3 75589.0 76226.2 79775.0 80005.6 1011.2 1042.3 1058.0 1059.2 1063.4 14696.1 14860.4 15103.7 15123.1 15510.9 36777.0 37077.3 37404.6 37579.0 37877.0 45541.5 45594.5 45666.8 45882.5 46192.5 8174.8 8331.8 8480.4 8487.9 8679.3 12390.4 12481.6 12498.8 12759.9 12802.8 10801.7 10834.5 10872.8 10970.2 11265.5 9845.1 9898.2 9927.4 10006.5 10188.4 10791.8 10820.6 10846.3 10887.6 11243.2 8219.8 8381.7 8383.7 8649.3 8667.6 10584.3 10625.5 10707.6 10708.3 10836.8 17:13:08 INFO - PID 26798 | 17:13:08 INFO - PID 26798 | [#3] mootools.html Cycles:180 Average:6314.72 Median:3541.85 stddev:4047.89 (114.3%) stddev-sans-first:4041.34 17:13:08 INFO - PID 26798 | Values: 1247.0 1300.3 1306.5 1313.2 1317.3 10089.2 10554.9 10557.2 10584.8 10897.3 10556.8 10746.8 10752.6 10767.1 10770.1 2261.6 2304.6 2329.1 2329.4 2343.6 2210.5 2274.4 2275.4 2279.8 2280.7 2226.1 2255.5 2283.1 2283.2 2294.2 2175.6 2212.3 2235.4 2240.9 2245.6 2129.4 2240.7 2277.1 2279.2 2282.3 10164.5 10187.2 10202.2 10259.6 10298.1 5657.9 5834.3 5844.5 5870.8 5874.6 3227.7 3457.3 3489.8 3527.4 3556.3 1127.3 1130.6 1148.1 1163.9 1169.1 15105.7 15184.5 15238.3 15260.5 15292.2 4812.3 4945.4 5080.3 5124.8 5140.7 10770.4 10804.3 10819.4 10823.5 10868.6 5381.1 5568.4 5598.2 5747.9 5753.8 5122.4 5191.6 5202.3 5224.4 5236.9 4000.0 4008.7 4050.4 4072.6 4093.5 1163.1 1175.2 1185.0 1198.9 1201.1 672.5 697.9 701.5 711.6 717.4 5217.8 5386.2 5396.6 5405.4 5451.9 549.4 555.5 559.2 559.4 561.0 3263.9 3282.5 3759.8 3767.8 3821.2 12299.3 12971.2 13138.1 13139.0 13139.9 12548.2 12756.6 13014.1 13057.2 13341.3 7639.2 7682.0 7718.7 7773.2 7783.3 5596.6 5647.9 5720.1 5721.3 5752.7 11847.8 12072.5 12151.9 12279.8 12445.2 12195.6 12264.8 12371.1 12528.6 12643.3 7306.0 7328.0 7337.3 7432.4 7436.9 9429.2 9645.0 9649.1 9650.8 9663.9 7885.2 8135.5 8158.1 8243.5 8368.5 8011.6 8142.5 8185.1 8199.3 8229.7 7549.9 7638.5 7679.7 7686.0 7713.5 5243.6 5264.6 5344.8 5474.8 5555.1 5297.5 5313.6 5320.6 5339.5 5562.8 17:13:08 INFO - PID 26798 | 17:13:08 INFO - PID 26798 | [#4] prototype.html Cycles:180 Average:4634.83 Median:5007.77 stddev:1366.55 (27.3%) stddev-sans-first:1332.25 17:13:08 INFO - PID 26798 | Values: 363.4 387.8 394.1 396.9 405.5 5288.6 5425.6 5458.9 5462.4 5514.3 5239.9 5296.8 5302.9 5309.9 5332.1 4048.3 4066.5 4080.9 4085.4 4098.6 3905.4 4048.6 4084.3 4085.8 4088.8 4001.4 4005.8 4022.0 4028.1 4037.8 4005.4 4027.4 4029.4 4030.9 4071.4 3546.2 3557.4 3561.9 3562.2 3564.1 5192.4 5192.6 5217.7 5242.9 5246.6 4740.3 4740.8 4748.3 4749.6 4750.3 5498.6 5646.0 5660.5 5661.9 5673.5 3940.4 3950.4 3951.5 3959.3 3988.1 5742.9 5921.3 5942.2 5979.6 6020.2 4026.7 4040.2 4043.3 4048.6 4059.9 4105.8 4122.4 4131.8 4135.6 4138.5 4675.6 4704.2 4730.2 4734.6 4752.2 5633.5 5646.9 5647.7 5658.7 5662.9 1398.7 1412.9 1413.1 1416.4 1425.8 883.5 940.5 956.9 960.9 962.2 4939.8 4963.0 4971.6 4992.1 5016.6 5840.3 5852.6 5890.4 5901.9 5954.1 4821.7 4934.6 4955.8 4983.0 4998.0 3101.7 3116.6 3125.1 3131.9 3136.5 4999.8 5000.3 5002.9 5026.4 5032.8 5770.4 5897.6 5943.3 5949.4 5961.4 4978.5 4991.2 4991.9 5003.9 5005.4 5673.7 5788.4 5821.4 5885.4 5891.2 5793.0 5793.2 5800.5 5805.3 5821.0 4822.3 4950.5 4962.0 5000.8 5010.1 4008.4 4037.2 4054.9 4068.1 4080.8 5718.7 5916.7 5917.2 5944.1 5970.0 5652.7 5674.4 5684.8 5700.7 5723.6 5658.0 5679.6 5691.9 5693.5 5739.1 5477.6 5575.6 5630.1 5633.0 5658.9 5720.5 5775.5 5779.4 5780.0 5786.9 5434.2 5560.5 5566.5 5609.7 5613.4 17:13:08 INFO - PID 26798 | 17:13:08 INFO - PID 26798 | [#5] yui.html Cycles:180 Average:15075.30 Median:42154.37 stddev:17696.88 (42.0%) stddev-sans-first:17713.44 17:13:08 INFO - PID 26798 | Values: 664.1 679.0 728.3 763.1 782.8 11438.7 12051.8 13124.2 14000.0 14048.2 14015.3 14123.4 14916.6 14978.3 15024.2 848.4 866.9 867.5 868.8 872.8 912.1 915.8 915.9 918.8 919.0 952.9 957.5 958.0 958.7 960.6 949.3 951.3 952.1 956.0 958.3 701.2 701.9 702.1 704.9 706.4 12961.2 13165.3 13173.7 13207.9 13249.4 14119.8 14151.4 14277.8 14492.5 14546.9 12453.7 12486.1 12536.9 12594.6 12661.2 2955.3 2968.2 2975.3 2985.1 2988.0 65907.3 65989.3 66124.3 67705.3 67707.7 10886.6 11075.6 11093.7 12122.2 12566.2 21551.0 22013.3 22340.0 22722.2 23109.2 6240.5 6496.4 6528.7 6534.6 6596.0 3116.2 3153.1 3154.4 3168.2 3187.0 3497.8 3539.5 3559.5 4034.9 4155.3 796.2 815.9 831.3 831.9 835.1 576.6 585.2 601.4 605.2 614.5 9305.9 9347.7 9793.6 9855.1 10148.5 617.2 623.9 629.4 637.3 639.0 4317.2 4412.2 4453.7 4490.1 4525.7 61183.0 61248.0 62767.7 62825.0 63138.0 53110.2 54871.2 55037.2 55428.2 57863.7 47890.5 49494.3 49606.5 50627.0 50970.5 8854.1 10351.9 10557.9 10725.0 10994.7 24844.3 25295.5 25600.6 25842.5 26136.3 42052.4 42256.4 42515.8 43180.4 43313.8 14131.3 14229.7 14248.6 14373.6 14551.9 15044.9 15416.3 15643.1 16338.4 16384.1 13668.8 14041.6 14112.5 14224.2 14350.6 13573.2 13800.2 13927.2 14075.6 14202.8 12435.0 12903.9 12904.2 13047.7 13144.4 9075.9 9130.8 9476.6 9553.8 9828.5 10404.4 10784.8 10868.8 10981.1 11062.9 17:13:08 INFO - PID 26798 | -------- Summary: end -------- 17:13:08 INFO - PID 26798 | 17:13:08 INFO - TEST-INFO | 26798: exit 0 17:13:08 INFO - TEST-OK | dromaeo_css | took 1118122ms 17:13:08 INFO - TEST-START | kraken 17:13:08 INFO - operating with platform_type : linux_ 17:13:08 INFO - Initialising browser for kraken test... 17:13:08 INFO - TEST-INFO | started process 27212 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppl_QL4/profile http://localhost:36669/getInfo.html) 17:13:09 INFO - PID 27212 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2932: String.localeCompare is deprecated; use String.prototype.localeCompare instead 17:13:12 INFO - PID 27212 | __metrics Screen width/height:1600/1200 17:13:12 INFO - PID 27212 | colorDepth:24 17:13:12 INFO - PID 27212 | Browser inner width/height: 1024/695 17:13:12 INFO - PID 27212 | __metrics 17:13:14 INFO - TEST-INFO | 27212: exit 0 17:13:14 INFO - Browser initialized. 17:13:14 INFO - Running cycle 1/1 for kraken test... 17:13:14 INFO - TEST-INFO | started process 27385 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppl_QL4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:13:26 INFO - PID 27385 | RSS: Main: 161624064 17:13:26 INFO - PID 27385 | 17:13:28 INFO - PID 27385 | Cycle 1(1): loaded http://localhost:36669/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36669/tests/kraken/driver.html?testName=audio-beat-detection) 17:13:30 INFO - PID 27385 | RSS: Main: 167034880 17:13:30 INFO - PID 27385 | 17:13:32 INFO - PID 27385 | Cycle 1(1): loaded http://localhost:36669/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36669/tests/kraken/driver.html?testName=audio-dft) 17:13:33 INFO - PID 27385 | RSS: Main: 166789120 17:13:33 INFO - PID 27385 | 17:13:36 INFO - PID 27385 | Cycle 1(1): loaded http://localhost:36669/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36669/tests/kraken/driver.html?testName=audio-fft) 17:13:36 INFO - PID 27385 | RSS: Main: 162230272 17:13:36 INFO - PID 27385 | 17:13:38 INFO - PID 27385 | Cycle 1(1): loaded http://localhost:36669/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36669/tests/kraken/driver.html?testName=audio-oscillator) 17:13:39 INFO - PID 27385 | RSS: Main: 162521088 17:13:39 INFO - PID 27385 | 17:13:41 INFO - PID 27385 | Cycle 1(1): loaded http://localhost:36669/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36669/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:13:42 INFO - PID 27385 | RSS: Main: 162295808 17:13:42 INFO - PID 27385 | 17:13:45 INFO - PID 27385 | Cycle 1(1): loaded http://localhost:36669/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36669/tests/kraken/driver.html?testName=imaging-darkroom) 17:13:45 INFO - PID 27385 | RSS: Main: 167456768 17:13:45 INFO - PID 27385 | 17:13:49 INFO - PID 27385 | Cycle 1(1): loaded http://localhost:36669/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36669/tests/kraken/driver.html?testName=imaging-desaturate) 17:13:50 INFO - PID 27385 | RSS: Main: 164511744 17:13:50 INFO - PID 27385 | 17:13:53 INFO - PID 27385 | Cycle 1(1): loaded http://localhost:36669/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36669/tests/kraken/driver.html?testName=json-parse-financial) 17:13:53 INFO - PID 27385 | RSS: Main: 165175296 17:13:53 INFO - PID 27385 | 17:13:55 INFO - PID 27385 | Cycle 1(1): loaded http://localhost:36669/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36669/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:13:55 INFO - PID 27385 | RSS: Main: 165199872 17:13:55 INFO - PID 27385 | 17:13:57 INFO - PID 27385 | Cycle 1(1): loaded http://localhost:36669/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36669/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:13:58 INFO - PID 27385 | RSS: Main: 165543936 17:13:58 INFO - PID 27385 | 17:14:00 INFO - PID 27385 | Cycle 1(1): loaded http://localhost:36669/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36669/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:14:01 INFO - PID 27385 | RSS: Main: 165449728 17:14:01 INFO - PID 27385 | 17:14:03 INFO - PID 27385 | Cycle 1(1): loaded http://localhost:36669/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36669/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:14:04 INFO - PID 27385 | RSS: Main: 165179392 17:14:04 INFO - PID 27385 | 17:14:07 INFO - PID 27385 | Cycle 1(1): loaded http://localhost:36669/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36669/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:14:08 INFO - PID 27385 | RSS: Main: 165527552 17:14:08 INFO - PID 27385 | 17:14:10 INFO - PID 27385 | Cycle 1(1): loaded http://localhost:36669/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36669/tests/kraken/driver.html?testName=ai-astar) 17:14:10 INFO - PID 27385 | RSS: Main: 166805504 17:14:10 INFO - PID 27385 | 17:14:10 INFO - PID 27385 | __start_tp_report 17:14:10 INFO - PID 27385 | _x_x_mozilla_page_load 17:14:10 INFO - PID 27385 | _x_x_mozilla_page_load_details 17:14:10 INFO - PID 27385 | |i|pagename|runs| 17:14:10 INFO - PID 27385 | |0;ai-astar;105;112;112;112;110;111;111;112;111;112 17:14:10 INFO - PID 27385 | |1;audio-beat-detection;148;123;126;165;131;128;123;124;149;124 17:14:10 INFO - PID 27385 | |2;audio-dft;165;164;164;162;163;163;168;172;165;164 17:14:10 INFO - PID 27385 | |3;audio-fft;74;80;78;98;75;76;75;78;100;77 17:14:10 INFO - PID 27385 | |4;audio-oscillator;85;84;106;84;83;82;96;84;84;106 17:14:10 INFO - PID 27385 | |5;imaging-gaussian-blur;114;115;114;114;114;115;114;114;114;114 17:14:10 INFO - PID 27385 | |6;imaging-darkroom;153;151;151;154;152;151;150;150;152;151 17:14:10 INFO - PID 27385 | |7;imaging-desaturate;94;95;95;95;95;94;96;95;96;95 17:14:10 INFO - PID 27385 | |8;json-parse-financial;54;55;55;55;56;56;57;55;55;56 17:14:10 INFO - PID 27385 | |9;json-stringify-tinderbox;55;56;55;56;56;65;55;55;55;57 17:14:10 INFO - PID 27385 | |10;stanford-crypto-aes;82;82;81;83;81;86;82;83;83;83 17:14:10 INFO - PID 27385 | |11;stanford-crypto-ccm;141;130;133;132;137;138;152;132;183;137 17:14:10 INFO - PID 27385 | |12;stanford-crypto-pbkdf2;194;200;191;192;191;187;215;191;186;187 17:14:10 INFO - PID 27385 | |13;stanford-crypto-sha256-iterative;78;77;75;76;77;75;75;73;72;74 17:14:10 INFO - PID 27385 | __end_tp_report 17:14:10 INFO - PID 27385 | __start_cc_report 17:14:10 INFO - PID 27385 | _x_x_mozilla_cycle_collect,760 17:14:10 INFO - PID 27385 | __end_cc_report 17:14:10 INFO - PID 27385 | __startTimestamp1494893650421__endTimestamp 17:14:10 INFO - PID 27385 | 17:14:10 INFO - PID 27385 | ------- Summary: start ------- 17:14:10 INFO - PID 27385 | Number of tests: 14 17:14:10 INFO - PID 27385 | 17:14:10 INFO - PID 27385 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:2.15 (1.9%) stddev-sans-first:0.73 17:14:10 INFO - PID 27385 | Values: 105.0 112.0 112.0 112.0 110.0 111.0 111.0 112.0 111.0 112.0 17:14:10 INFO - PID 27385 | 17:14:10 INFO - PID 27385 | [#1] audio-beat-detection Cycles:10 Average:134.10 Median:129.50 stddev:14.65 (11.3%) stddev-sans-first:14.66 17:14:10 INFO - PID 27385 | Values: 148.0 123.0 126.0 165.0 131.0 128.0 123.0 124.0 149.0 124.0 17:14:10 INFO - PID 27385 | 17:14:10 INFO - PID 27385 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.50 stddev:2.94 (1.8%) stddev-sans-first:3.12 17:14:10 INFO - PID 27385 | Values: 165.0 164.0 164.0 162.0 163.0 163.0 168.0 172.0 165.0 164.0 17:14:10 INFO - PID 27385 | 17:14:10 INFO - PID 27385 | [#3] audio-fft Cycles:10 Average:81.10 Median:77.50 stddev:9.61 (12.4%) stddev-sans-first:9.84 17:14:10 INFO - PID 27385 | Values: 74.0 80.0 78.0 98.0 75.0 76.0 75.0 78.0 100.0 77.0 17:14:10 INFO - PID 27385 | 17:14:10 INFO - PID 27385 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:84.00 stddev:9.58 (11.4%) stddev-sans-first:10.03 17:14:10 INFO - PID 27385 | Values: 85.0 84.0 106.0 84.0 83.0 82.0 96.0 84.0 84.0 106.0 17:14:10 INFO - PID 27385 | 17:14:10 INFO - PID 27385 | [#5] imaging-gaussian-blur Cycles:10 Average:114.20 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 17:14:10 INFO - PID 27385 | Values: 114.0 115.0 114.0 114.0 114.0 115.0 114.0 114.0 114.0 114.0 17:14:10 INFO - PID 27385 | 17:14:10 INFO - PID 27385 | [#6] imaging-darkroom Cycles:10 Average:151.50 Median:151.50 stddev:1.27 (0.8%) stddev-sans-first:1.22 17:14:10 INFO - PID 27385 | Values: 153.0 151.0 151.0 154.0 152.0 151.0 150.0 150.0 152.0 151.0 17:14:10 INFO - PID 27385 | 17:14:10 INFO - PID 27385 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 17:14:10 INFO - PID 27385 | Values: 94.0 95.0 95.0 95.0 95.0 94.0 96.0 95.0 96.0 95.0 17:14:10 INFO - PID 27385 | 17:14:10 INFO - PID 27385 | [#8] json-parse-financial Cycles:10 Average:55.40 Median:55.50 stddev:0.84 (1.5%) stddev-sans-first:0.73 17:14:10 INFO - PID 27385 | Values: 54.0 55.0 55.0 55.0 56.0 56.0 57.0 55.0 55.0 56.0 17:14:10 INFO - PID 27385 | 17:14:10 INFO - PID 27385 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:56.00 stddev:3.06 (5.5%) stddev-sans-first:3.20 17:14:10 INFO - PID 27385 | Values: 55.0 56.0 55.0 56.0 56.0 65.0 55.0 55.0 55.0 57.0 17:14:10 INFO - PID 27385 | 17:14:10 INFO - PID 27385 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:1.43 (1.7%) stddev-sans-first:1.50 17:14:10 INFO - PID 27385 | Values: 82.0 82.0 81.0 83.0 81.0 86.0 82.0 83.0 83.0 83.0 17:14:10 INFO - PID 27385 | 17:14:10 INFO - PID 27385 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:137.50 stddev:15.88 (11.6%) stddev-sans-first:16.85 17:14:10 INFO - PID 27385 | Values: 141.0 130.0 133.0 132.0 137.0 138.0 152.0 132.0 183.0 137.0 17:14:10 INFO - PID 27385 | 17:14:10 INFO - PID 27385 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.40 Median:191.50 stddev:8.60 (4.5%) stddev-sans-first:9.12 17:14:10 INFO - PID 27385 | Values: 194.0 200.0 191.0 192.0 191.0 187.0 215.0 191.0 186.0 187.0 17:14:10 INFO - PID 27385 | 17:14:10 INFO - PID 27385 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.20 Median:75.50 stddev:1.87 (2.5%) stddev-sans-first:1.69 17:14:10 INFO - PID 27385 | Values: 78.0 77.0 75.0 76.0 77.0 75.0 75.0 73.0 72.0 74.0 17:14:10 INFO - PID 27385 | -------- Summary: end -------- 17:14:10 INFO - PID 27385 | 17:14:11 INFO - TEST-INFO | 27385: exit 0 17:14:11 INFO - TEST-OK | kraken | took 62608ms 17:14:11 INFO - SUITE-END | took 1180s 17:14:11 INFO - Completed test suite (00:19:40) 17:14:11 INFO - javascript benchmark 17:14:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6659.278867867221, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2672.394888459162, 2701.1086341507303, 2710.810243282971, 2723.9591406128898, 2728.8362698238116, 5139.691618502892, 5186.507281808227, 5195.740212989345, 5200.193969934657, 5251.238570407293, 5139.486051394859, 5213.3743950725875, 5296.735163241832, 5304.6286759926825, 5314.707691076999, 4612.377329060568, 4612.746298953556, 4653.0, 4669.649776266793, 4692.2257827458425, 4655.720656760588, 4687.343771871941, 4776.355192049064, 4794.81468905112, 4832.106060378841, 4501.077279157797, 4711.222648263032, 4719.834805781781, 4751.0972915146185, 4767.404074490689, 4631.884202894921, 4660.3941487606735, 4709.2229782085915, 4723.173444647207, 4743.051389722069, 4623.884402889955, 4647.34937108805, 4661.394018777537, 4663.393758811367, 4745.050989802019, 5184.0, 5225.059489291926, 5229.084910140748, 5233.685978841244, 5272.024675435018, 5499.120140777496, 5568.554515638739, 5569.832905012856, 5573.470520300565, 5573.832785016456, 5666.093425051972, 5673.00722373583, 5677.517411020068, 5681.829545113612, 5689.146628005791, 5268.446813084647, 5269.710165940834, 5309.973450132725, 5313.681179129226, 5316.6544174628525, 5707.258056452718, 5710.229119068956, 5761.9135712964335, 5771.451712087345, 5790.855228619234, 5428.83713488596, 5431.83704488866, 5477.589180811455, 5530.087535556588, 5554.527865131509, 5525.778968841281, 5556.0, 5607.214989901417, 5632.943670563324, 5684.118961560965, 5570.220169176318, 5577.6932268724795, 5580.693061881554, 5589.944100559023, 5607.327120745536, 5465.699386533779, 5518.0, 5542.307211598551, 5584.636998595079, 5599.552035837123, 4597.862064138081, 4659.906801864012, 4679.438467383936, 4679.461861885927, 4704.1767690654, 4034.11249525104, 4051.8784436466954, 4053.8986525336513, 4081.959180408158, 4087.693422993287, 4779.091972525279, 4893.779779909913, 4895.118878601886, 4904.288878112654, 4907.1903135982875, 5601.887962240814, 5663.292088488939, 5686.147077938343, 5696.401877802854, 5743.023685973395, 4905.656604037683, 4907.263910413395, 4907.288443175719, 4909.4354149273295, 4910.631702622318, 4992.775325110379, 5030.773615187325, 5034.345535080416, 5041.722705251246, 5071.594272458195, 4806.519348065305, 4839.322494850724, 4848.0788650156355, 4850.854474365704, 4853.684510506806, 5548.250986116823, 5608.38307786135, 5610.887782244414, 5621.775128994795, 5741.25363702716, 4765.166095933128, 4793.0413917216, 4826.734529600905, 4828.179209534458, 4856.587190088882, 5518.144687573433, 5587.497125258747, 5595.160725891149, 5596.468335508121, 5648.039833228278, 5679.602427830012, 5679.630823996427, 5689.118186681071, 5695.715214239189, 5697.658140511417, 5343.145096784496, 5414.566834653139, 5416.864578385572, 5499.422560631237, 5500.119980803052, 5432.592555558428, 5455.890882182413, 5532.751026203911, 5543.6396634218645, 5552.333719953632, 5393.595480338912, 5431.456854314695, 5440.836774896601, 5478.260434841405, 5479.479449452296, 5456.972715136399, 5508.980838544882, 5513.917291240715, 5516.696581688046, 5560.777568897199, 5316.840494785162, 5361.115415956324, 5430.755615997211, 5434.918476222781, 5482.122860342326], "value": 5089.994568314874, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.8696847598956, 738.700826165403, 756.0360540311102, 1054.3831858362853, 1055.6938487838527, 31928.36143277136, 32470.18824529388, 32625.83687081564, 32651.183720407003, 32709.18227044319, 33672.32655346891, 33910.0, 33981.32037359251, 34011.48982765261, 34369.14077148073, 6515.087887695727, 6612.371824676648, 6679.966600166992, 6785.6267905265195, 6798.864022719543, 6861.1080559527445, 6946.513744037894, 6947.617881016542, 6949.756758513453, 6969.05917701109, 6910.723571057177, 6974.163100427931, 7007.964960175192, 7037.190723066836, 7039.824004399879, 6965.442764578846, 6985.336393042653, 7002.754903578376, 7012.614306213156, 7017.157941047081, 6382.297947225801, 6397.456216221627, 6397.6801159941815, 6409.903851442232, 6435.517336199757, 32464.18839529007, 32474.18814529632, 32477.18807029843, 32510.349793004243, 32524.34951300961, 3054.57235986962, 3089.1813669377634, 3091.211741006029, 3098.442280389529, 3100.798448100866, 24625.87687061571, 24628.50742985148, 24689.62965555518, 24867.87566062176, 24884.253472395678, 3174.238182836126, 3175.523671449278, 3191.0267368452614, 3207.3264614430996, 3219.114743445571, 144247.2787636055, 145819.0, 152301.0, 154223.0, 154800.0, 38563.614363856, 38601.61398386036, 38633.42049869254, 38645.42031869524, 38744.80627596844, 39814.0, 39971.80014099911, 40059.79970100189, 40123.39814902779, 40320.34714272112, 12059.51761929513, 12070.879291207151, 12083.093767967262, 12098.213616114925, 12143.14997950135, 9678.370905891095, 9695.951520242354, 9702.223822094216, 9710.320277580502, 9761.560729767178, 12382.62852114438, 12458.75082498345, 12518.749625007631, 12532.561360352343, 12656.493740250471, 5045.672031317952, 5157.355330583677, 5167.354080739908, 5224.660397074178, 5297.364316282071, 867.0722327109931, 867.319154463743, 887.1704955866286, 902.9909700903038, 918.7657147427363, 20534.486637833874, 21084.57830843405, 21321.147154113973, 21510.354689359032, 21520.784792151877, 952.5618215620892, 955.254901177083, 964.6961207219704, 975.2636759246724, 976.199516396548, 10782.0, 10925.180611454172, 11026.173037022256, 11102.944485277521, 11326.32042077478, 182785.0, 182789.0, 183727.0, 183921.0, 184183.0, 39919.0, 40235.79882100571, 40296.0, 40318.0, 40333.596664032986, 1155.4742592120565, 1218.9268643881574, 1219.6706889139882, 1221.9327936963375, 1230.3971054183385, 19069.237230510626, 19693.0, 20578.0, 20642.58714825725, 20871.582568348244, 29231.85384073066, 29489.410211796072, 29509.114726558237, 29543.0, 29560.260993475335, 152965.23517382343, 154214.0, 154298.0, 154465.0, 154828.0, 28386.290342741595, 28690.42202678873, 29365.55951660684, 30592.0, 30671.846640766653, 36002.63997359993, 36285.0, 36563.0, 36955.260894781415, 36971.44542831806, 25761.227163185133, 26803.86598067075, 27270.318242044108, 27397.58903616487, 27635.0, 26950.32624184411, 27298.317542061606, 27771.166864994084, 27999.860000699868, 28918.0, 30845.537316939815, 30918.22704432407, 30952.0, 30967.0709878704, 30969.0709278722, 26785.464290714466, 26850.0, 26938.86530567413, 27361.863190684715, 28186.0, 21318.407836877097, 22267.0, 22282.554348912607, 22445.438864027878, 22448.663270050634], "value": 14380.898679910133, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.7807672895002, 410.3741793764511, 413.61740390139124, 435.44698233243764, 436.25182811478317, 11606.59376921808, 13271.402786874589, 16833.747493787603, 17495.650086998252, 17528.91235543824, 17802.465926022207, 18073.1867065982, 18079.09604519772, 18449.262029518803, 19066.0, 5476.26070480486, 5558.333000040001, 5641.18202860585, 5662.6602403855695, 5668.149777533383, 5452.83641490754, 5549.500544950954, 5560.582956278275, 5566.916496252559, 5574.498295153436, 5414.0, 5422.945770542303, 5517.806876759314, 5534.723263836812, 5536.944630553703, 5463.344398672165, 5542.806001789938, 5551.306086739158, 5553.111502159655, 5559.8888022239325, 4924.0, 5001.349824522788, 5003.199488081889, 5024.2965984761795, 5074.797008119671, 22285.66571501429, 22451.663225051638, 22515.21196758122, 22556.436089097904, 22789.746563938977, 1648.5878530367409, 1683.0406668199132, 1684.2589260725242, 1685.561753943971, 1687.4094067076549, 14226.368121897482, 14444.277786110653, 14932.40270389194, 15198.924005380013, 15274.541763747106, 2077.096463038583, 2099.769025407204, 2128.2231985325398, 2130.5951869144815, 2138.5295235048266, 83323.33353332899, 92546.67079962768, 93039.0, 94182.0, 95965.0, 11022.338659680445, 11091.5563377464, 11150.721231969103, 11320.26418282809, 11552.537898484135, 15624.375024998873, 15722.13528255957, 15748.76376854348, 15807.446739364066, 15842.60393490149, 7225.710971561079, 7463.589502577411, 7558.319751222416, 7685.654145563463, 7692.230776922375, 6690.719902723918, 6707.429868461138, 6883.931160688329, 6899.310068993061, 6910.412614927687, 6892.172939247323, 7079.327463890922, 7088.964555177191, 7230.0, 7257.818554536178, 2000.2099170827441, 2025.908834102469, 2042.5302180498568, 2067.576146889884, 2169.7287839020123, 826.7313123234973, 856.3277826905849, 860.3375400941366, 863.6977058029765, 886.9733907982771, 16861.241244144043, 16939.745903811454, 16993.490195293914, 17290.91354543219, 17765.7335139973, 856.7301300090452, 860.9311255099577, 867.4665080975154, 872.842888280103, 882.9514376709215, 9331.113544213289, 9381.765455863659, 9714.319997600242, 9726.805463890683, 9799.755006124762, 357394.0, 361316.0, 369981.0, 373276.0, 374317.0, 73789.26210737824, 75589.00294938151, 76226.23773762303, 79775.0, 80005.59997200093, 1011.2365164300905, 1042.3485321673954, 1058.0213302694976, 1059.2373491086405, 1063.3885515828429, 14696.11823290606, 14860.405583776961, 15103.697926041637, 15123.092614442729, 15510.922445387701, 36777.0, 37077.258454831295, 37404.62595374011, 37579.0, 37877.0, 45541.54458455373, 45594.54405455903, 45666.77166614146, 45882.54117458783, 46192.538074618824, 8174.836503269782, 8331.750047498585, 8480.406371553932, 8487.915120848713, 8679.305655547667, 12390.442430090487, 12481.625551233477, 12498.812517812423, 12759.936200319311, 12802.807957880454, 10801.729956750829, 10834.512446939749, 10872.782544349227, 10970.177236707119, 11265.493052812479, 9845.064718851698, 9898.158656514277, 9927.354721943051, 10006.549705263425, 10188.439635820101, 10791.784164316827, 10820.56717731282, 10846.29499082557, 10887.618933337295, 11243.156763242627, 8219.794505137419, 8381.706640267561, 8383.748487545383, 8649.308055355683, 8667.566621668766, 10584.312019718695, 10625.468726563795, 10707.625233116803, 10708.250422470664, 10836.837447438453], "value": 8764.866637109044, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1246.981295280571, 1300.2848433361648, 1306.4512904580076, 1313.225197133691, 1317.3215793866157, 10089.192864570836, 10554.894451055487, 10557.208209384298, 10584.841227381596, 10897.346159230452, 10556.78886422273, 10746.785064298729, 10752.623658171946, 10767.084797792177, 10770.138388928886, 2261.6268315727884, 2304.6197377432786, 2329.1149363241943, 2329.406001469623, 2343.55472460232, 2210.53578748463, 2274.442761523429, 2275.3628983884455, 2279.794818466338, 2280.726312842453, 2226.065052677879, 2255.4699645583273, 2283.1095872609694, 2283.1894677389537, 2294.1855641247366, 2175.630142875715, 2212.281008672188, 2235.418791114306, 2240.932772016842, 2245.640697488402, 2129.361191642501, 2240.7423146338056, 2277.077783497686, 2279.247848210087, 2282.3267136194863, 10164.542595583216, 10187.235957303157, 10202.183825293958, 10259.589616415335, 10298.12465940396, 5657.915131272993, 5834.2998840139035, 5844.4739973402175, 5870.7945221917025, 5874.618149820248, 3227.7399826175497, 3457.343104810078, 3489.7545282886904, 3527.435610302365, 3556.2574338574173, 1127.3236058364917, 1130.6325444230577, 1148.1331594646072, 1163.8884864953948, 1169.05306701572, 15105.697886042328, 15184.468543601031, 15238.314275857501, 15260.542183734506, 15292.235388230543, 4812.278158276286, 4945.381827271591, 5080.314157588752, 5124.769385377667, 5140.717260550631, 10770.407627580402, 10804.297720648132, 10819.350838949687, 10823.512941917632, 10868.565257389615, 5381.1121165007335, 5568.387477377485, 5598.216249725042, 5747.885042299215, 5753.769849205984, 5122.410922743932, 5191.5846732261325, 5202.297689811827, 5224.37307523092, 5236.869078273074, 4000.0, 4008.6592639625374, 4050.432939388488, 4072.6334629883454, 4093.488313960755, 1163.1102206811795, 1175.189119507554, 1185.040117504824, 1198.9040876730014, 1201.1171788735273, 672.5023482622823, 697.891826766852, 701.4773993374866, 711.5588335232086, 717.4188906985358, 5217.791288348423, 5386.218998245311, 5396.64921780083, 5405.378381486101, 5451.945480545144, 549.409384911222, 555.5444535480867, 559.1724248112815, 559.3539461921487, 560.9635373700696, 3263.8549042715617, 3282.5076238564407, 3759.755615884959, 3767.830447629863, 3821.159344944108, 12299.262044277371, 12971.156874803108, 13138.080334376693, 13139.0, 13139.934300328438, 12548.24710517372, 12756.553520626734, 13014.089013768946, 13057.151285166434, 13341.266230357229, 7639.159692433939, 7682.0, 7718.652660630285, 7773.18381569927, 7783.260590243918, 5596.552275817843, 5647.858803529944, 5720.11338242573, 5721.313442386941, 5752.712364381848, 11847.76304473923, 12072.517099315928, 12151.939240303742, 12279.754404911673, 12445.191062580903, 12195.634130976085, 12264.754704905674, 12371.072169587496, 12528.624141275777, 12643.304618245716, 7305.963470182615, 7327.963360183165, 7337.3396394322635, 7432.3682486987045, 7436.851262974818, 9429.198518125762, 9644.987276336164, 9649.083337082966, 9650.806983860142, 9663.855042174233, 7885.172056934169, 8135.471194372347, 8158.1026087129185, 8243.505389676639, 8368.497890126611, 8011.599420029092, 8142.51144931306, 8185.099639039582, 8199.262066414052, 8229.670813167646, 7549.9245007549225, 7638.465307428427, 7679.731209407644, 7686.0, 7713.537187768752, 5243.58051355883, 5264.578833693219, 5344.786208551614, 5474.808381706621, 5555.111182210827, 5297.470252974672, 5313.574914006947, 5320.57435405159, 5339.519443250126, 5562.777488900399], "value": 4734.7772813525635, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.40220337544724, 387.78477944740655, 394.12110992486737, 396.92260009298184, 405.54376326632536, 5288.5504732097725, 5425.593080518962, 5458.863528411786, 5462.426445223254, 5514.283143191389, 5239.921401178985, 5296.788128474866, 5302.867428314294, 5309.946900531003, 5332.093544097503, 4048.271311163989, 4066.471358723362, 4080.8571699990507, 4085.428040074392, 4098.569650186732, 3905.3946638270972, 4048.6356227939477, 4084.264832330179, 4085.836566537335, 4088.7751173685438, 4001.4197941298494, 4005.799710014502, 4021.9798901005456, 4028.1138149607186, 4037.7981100944835, 4005.439238506611, 4027.416024676435, 4029.395590661395, 4030.899227519321, 4071.3689378146437, 3546.2375589248436, 3557.3774589446743, 3561.928761424757, 3562.2163124112913, 3564.108972756811, 5192.416313024526, 5192.55863251624, 5217.686938783647, 5242.947570524284, 5246.606504512177, 4740.265258884844, 4740.786664600067, 4748.264019077049, 4749.62003039756, 4750.2874568814605, 5498.5876059295315, 5645.955498232799, 5660.462256085665, 5661.886762264731, 5673.546116310686, 3940.4089386591954, 3950.3876899080688, 3951.486306780129, 3959.3467077932105, 3988.122613025159, 5742.856428589277, 5921.348651648315, 5942.227510423617, 5979.641221526722, 6020.1872747179, 4026.697997650188, 4040.1717647882115, 4043.3126368516832, 4048.554658987509, 4059.89850253746, 4105.815238314283, 4122.361034039729, 4131.793410329472, 4135.627793498599, 4138.482689663792, 4675.649326300473, 4704.1767690654, 4730.178881130721, 4734.55021772931, 4752.1683705351425, 5633.492985631231, 5646.887062258814, 5647.689377084218, 5658.7170641467765, 5662.886742265132, 1398.6503374156462, 1412.8979396071081, 1413.1379858286437, 1416.355558221007, 1425.8146440962817, 883.5228976352826, 940.5045976896766, 956.933014688965, 960.8894977077586, 962.2109869906749, 4939.827106051271, 4963.0, 4971.552560269593, 4992.101421744048, 5016.573591244712, 5840.29916410025, 5852.619579727304, 5890.352061273256, 5901.852453688606, 5954.136650185699, 4821.710697358169, 4934.61978544698, 4955.776990035457, 4983.0, 4997.950020499821, 3101.674324195972, 3116.641586217614, 3125.1249650098007, 3131.890383836555, 3136.4631330647817, 4999.825006124841, 5000.349954505891, 5002.924956125588, 5026.447090820006, 5032.823851165192, 5770.42295770428, 5897.557683173779, 5943.286805583358, 5949.405059494016, 5961.374055724174, 4978.47725988766, 4991.176455884738, 4991.875203119951, 5003.924941125886, 5005.424376196784, 5673.74468148926, 5788.421157884178, 5821.359650438364, 5885.411458854252, 5891.23413956183, 5793.0, 5793.246877905845, 5800.477956983892, 5805.332386775575, 5820.970895145497, 4822.348982887265, 4950.529699678525, 4962.032403681392, 5000.824971125993, 5010.123228434936, 4008.398740188995, 4037.152198038445, 4054.8986275343354, 4068.105016896278, 4080.755154690728, 5718.714064296852, 5916.733746981482, 5917.201177841109, 5944.138099975566, 5969.970150149222, 5652.7173641318595, 5674.375818659862, 5684.806190699834, 5700.743466544099, 5723.5707321950185, 5657.971710141587, 5679.563863862304, 5691.857703557444, 5693.544516438592, 5739.110437882135, 5477.643953143033, 5575.578227551949, 5630.0991841305195, 5632.971835140798, 5658.886822263614, 5720.456556627114, 5775.5090817281, 5779.364269930388, 5780.0, 5786.855328616818, 5434.2120392542065, 5560.499555040065, 5566.526845218202, 5609.691466969192, 5613.410591887793], "value": 4217.877326057751, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.110092476082, 678.9830254243643, 728.275366010819, 763.0576238345642, 782.8356045230502, 11438.7140321492, 12051.75896482072, 13124.21254724716, 14000.0, 14048.157110573373, 14015.299235038257, 14123.364448599812, 14916.552503424915, 14978.251087445638, 15024.248787560633, 848.3594885861181, 866.8916385451819, 867.4578388507183, 868.8088620503511, 872.8167084912176, 912.0605776050645, 915.7664795477177, 915.8855143107112, 918.8024574716435, 918.9586468608928, 952.9475878826662, 957.5260246178152, 957.9856302155473, 958.7075941837737, 960.5533426956464, 949.2690628216304, 951.2770294576103, 952.105021279998, 955.9856602150974, 958.2621381536213, 701.2461603775911, 701.9052427922268, 702.0802748399561, 704.9295070492961, 706.3854446631464, 12961.222326660336, 13165.275909824955, 13173.736525269442, 13207.86792132076, 13249.403776830066, 14119.78820317696, 14151.363188656433, 14277.78583321251, 14492.492762753252, 14546.854531454655, 12453.688657783538, 12486.12597118202, 12536.937315313457, 12594.559190428383, 12661.240325580495, 2955.349823038928, 2968.1540760883045, 2975.2710585906593, 2985.0746268656785, 2987.9551806722916, 65907.34092659107, 65989.3401065988, 66124.3387566123, 67705.32294677089, 67707.66146169238, 10886.564537418573, 11075.556977720962, 11093.667189984313, 12122.151449398458, 12566.183198092094, 21551.0, 22013.339599812032, 22340.0, 22722.20472283462, 23109.191178309015, 6240.5319601030105, 6496.447801936888, 6528.673566321665, 6534.640594767334, 6595.967020164869, 3116.158637167952, 3153.0698443959086, 3154.447971605006, 3168.2237851726472, 3187.0120262718633, 3497.8251087445524, 3539.4513850353237, 3559.483874838186, 4034.899127521777, 4155.252054630135, 796.2197046894076, 815.9347252219808, 831.2767891934056, 831.8752187171973, 835.1231207232381, 576.6079066235001, 585.1953563849706, 601.3925934805877, 605.2434456928839, 614.4684847606877, 9305.860412093823, 9347.691323214756, 9793.559289831976, 9855.142008817362, 10148.543315550818, 617.1668247865346, 623.9344868788803, 629.3643420145686, 637.2703254773259, 639.0254861336499, 4317.179735850178, 4412.161689279027, 4453.665975051884, 4490.101979604092, 4525.683202175816, 61183.0, 61248.0, 62767.686161569814, 62825.0, 63138.0, 53110.20334694983, 54871.17693234605, 55037.174442383395, 55428.16857747137, 57863.710681446326, 47890.52109478861, 49494.257586136955, 49606.50393496091, 50627.0, 50970.49029509732, 8854.114588541095, 10351.896481035394, 10557.9472102639, 10724.997000839778, 10994.670159895217, 24844.254672359857, 25295.494090118464, 25600.615990760525, 25842.483150337262, 26136.34659133537, 42052.36921446119, 42256.36615450832, 42515.7874210627, 43180.352294714976, 43313.7834310839, 14131.293435327987, 14229.715405692035, 14248.572542823731, 14373.568792936228, 14551.92724036373, 15044.924775376054, 15416.306266217824, 15643.139627320606, 16338.428155014517, 16384.098874562012, 13668.83814875707, 14041.648958776112, 14112.50606228777, 14224.217668028357, 14350.641233968816, 13573.1856088635, 13800.171989680652, 13927.164370137823, 14075.648108797363, 14202.786958195842, 12435.0, 12903.935480322538, 12904.225746455242, 13047.739045218852, 13144.40850161726, 9075.909240907506, 9130.817383652156, 9476.620935162791, 9553.808923821623, 9828.5085745711, 10404.427756473468, 10784.838227426439, 10868.836967445337, 10981.121510279, 11062.944685276843], "value": 6805.950567966797, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1545.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 112.0, 112.0, 112.0, 110.0, 111.0, 111.0, 112.0, 111.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 123.0, 126.0, 165.0, 131.0, 128.0, 123.0, 124.0, 149.0, 124.0], "value": 134.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 164.0, 162.0, 163.0, 163.0, 168.0, 172.0, 165.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 80.0, 78.0, 98.0, 75.0, 76.0, 75.0, 78.0, 100.0, 77.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 106.0, 84.0, 83.0, 82.0, 96.0, 84.0, 84.0, 106.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 151.0, 151.0, 154.0, 152.0, 151.0, 150.0, 150.0, 152.0, 151.0], "value": 151.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 94.0, 96.0, 95.0, 96.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 55.0, 55.0, 56.0, 56.0, 57.0, 55.0, 55.0, 56.0], "value": 55.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 56.0, 56.0, 65.0, 55.0, 55.0, 55.0, 57.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 83.0, 81.0, 86.0, 82.0, 83.0, 83.0, 83.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 130.0, 133.0, 132.0, 137.0, 138.0, 152.0, 132.0, 183.0, 137.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 200.0, 191.0, 192.0, 191.0, 187.0, 215.0, 191.0, 186.0, 187.0], "value": 193.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 75.0, 76.0, 77.0, 75.0, 75.0, 73.0, 72.0, 74.0], "value": 75.2, "unit": "score"}]}]} 17:14:11 INFO - Return code: 0 17:14:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:14:11 INFO - # TBPL SUCCESS # 17:14:11 INFO - Running post-action listener: _resource_record_post_action 17:14:11 INFO - [mozharness: 2017-05-16 00:14:11.725431Z] Finished run-tests step (success) 17:14:11 INFO - Running post-run listener: _resource_record_post_run 17:14:11 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 8192; Write bytes: 374960128; Read time: 20; Write time: 191388 17:14:11 INFO - TinderboxPrint: CPU usage
13.3% 17:14:11 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 17:14:11 INFO - TinderboxPrint: I/O write bytes / time
374,960,128 / 191,388 17:14:11 INFO - TinderboxPrint: CPU idle
8,284.6 (86.7%) 17:14:11 INFO - TinderboxPrint: CPU user
1,213.4 (12.7%) 17:14:11 INFO - TinderboxPrint: Swap in / out
0 / 0 17:14:11 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 102424576; Read time: 0; Write time: 80044 17:14:11 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 4096; Write bytes: 271953920; Read time: 12; Write time: 111312 17:14:12 INFO - Running post-run listener: _upload_blobber_files 17:14:12 INFO - Blob upload gear active. 17:14:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:14:12 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 17:14:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:14:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:14:12 INFO - (blobuploader) - INFO - Open directory for files ... 17:14:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:14:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:14:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:14:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:14:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:14:16 INFO - (blobuploader) - INFO - Done attempting. 17:14:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:14:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:14:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:14:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:14:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:14:17 INFO - (blobuploader) - INFO - Done attempting. 17:14:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:14:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:14:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:14:18 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:14:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:14:18 INFO - (blobuploader) - INFO - Done attempting. 17:14:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:14:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:14:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:14:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:14:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:14:19 INFO - (blobuploader) - INFO - Done attempting. 17:14:19 INFO - (blobuploader) - INFO - Iteration through files over. 17:14:19 INFO - Return code: 0 17:14:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:14:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:14:19 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b7688da9d5a2a6ef52b6ae8d3c04e46558aeaeb3051a10aef2596abb9895a2187df3deab05248d63bbb75ea6e87fe07bbb829946ede7e05ff860279be882521", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e8ee9562fdfdaee0424c5ad220e8708a2abb42e94ae84fd8d1c879e018f81ff8d23061f027ba3741ac899f4dafe58c7100bee162afdfe1aef9bd58ae1bd09472", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0bd7b73bdad56bf044701cbadb85ba222d6d24ddc621ebf6d00a4d4a101fca899693bf0b176cf455a53ceade5a129b2a19cc7d88052f9f0af6e2c0a04e464a57", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e39ea7bf5c6c1cc2c5df62ae6af0b67851b5192b9b5f9662f9a4906fedd2b4ab61f52abe9363a5d2727029aa0bccd01aa31d4f7c2795f21604110b08ba505bc"} 17:14:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:14:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:14:19 INFO - Contents: 17:14:19 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b7688da9d5a2a6ef52b6ae8d3c04e46558aeaeb3051a10aef2596abb9895a2187df3deab05248d63bbb75ea6e87fe07bbb829946ede7e05ff860279be882521", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e8ee9562fdfdaee0424c5ad220e8708a2abb42e94ae84fd8d1c879e018f81ff8d23061f027ba3741ac899f4dafe58c7100bee162afdfe1aef9bd58ae1bd09472", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0bd7b73bdad56bf044701cbadb85ba222d6d24ddc621ebf6d00a4d4a101fca899693bf0b176cf455a53ceade5a129b2a19cc7d88052f9f0af6e2c0a04e464a57", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e39ea7bf5c6c1cc2c5df62ae6af0b67851b5192b9b5f9662f9a4906fedd2b4ab61f52abe9363a5d2727029aa0bccd01aa31d4f7c2795f21604110b08ba505bc"} 17:14:19 INFO - Running post-run listener: copy_logs_to_upload_dir 17:14:19 INFO - Copying logs to upload dir... 17:14:19 INFO - mkdir: /builds/slave/test/build/upload/logs 17:14:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.031217 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-05-15 17:14:19.000846) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-15 17:14:19.007971) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b7688da9d5a2a6ef52b6ae8d3c04e46558aeaeb3051a10aef2596abb9895a2187df3deab05248d63bbb75ea6e87fe07bbb829946ede7e05ff860279be882521", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e8ee9562fdfdaee0424c5ad220e8708a2abb42e94ae84fd8d1c879e018f81ff8d23061f027ba3741ac899f4dafe58c7100bee162afdfe1aef9bd58ae1bd09472", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0bd7b73bdad56bf044701cbadb85ba222d6d24ddc621ebf6d00a4d4a101fca899693bf0b176cf455a53ceade5a129b2a19cc7d88052f9f0af6e2c0a04e464a57", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e39ea7bf5c6c1cc2c5df62ae6af0b67851b5192b9b5f9662f9a4906fedd2b4ab61f52abe9363a5d2727029aa0bccd01aa31d4f7c2795f21604110b08ba505bc"} build_url:https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011174 build_url: 'https://queue.taskcluster.net/v1/task/WIw5Dk7pTR-0oB3GcXYf6A/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9b7688da9d5a2a6ef52b6ae8d3c04e46558aeaeb3051a10aef2596abb9895a2187df3deab05248d63bbb75ea6e87fe07bbb829946ede7e05ff860279be882521", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e8ee9562fdfdaee0424c5ad220e8708a2abb42e94ae84fd8d1c879e018f81ff8d23061f027ba3741ac899f4dafe58c7100bee162afdfe1aef9bd58ae1bd09472", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0bd7b73bdad56bf044701cbadb85ba222d6d24ddc621ebf6d00a4d4a101fca899693bf0b176cf455a53ceade5a129b2a19cc7d88052f9f0af6e2c0a04e464a57", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2e39ea7bf5c6c1cc2c5df62ae6af0b67851b5192b9b5f9662f9a4906fedd2b4ab61f52abe9363a5d2727029aa0bccd01aa31d4f7c2795f21604110b08ba505bc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-15 17:14:19.036006) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-15 17:14:19.036294) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1494892278.629216-1074880772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-15 17:14:19.121014) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-15 17:14:19.121318) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-15 17:14:19.121605) ========= ========= Total master_lag: 0.21 =========