builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-007 starttime: 1486643639.84 results: success (0) revision: 75bda9957ea872ab71fbfa63c8f4d57e2458afb6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 04:33:59.844502) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 04:33:59.844974) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 04:33:59.845248) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 04:33:59.861380) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 04:33:59.861680) ========= 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=923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-09 04:33:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 140M=0s 2017-02-09 04:34:00 (140 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.303398 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 04:34:00.178612) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 04:34:00.178967) ========= 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=923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017426 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 04:34:00.228471) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 04:34:00.228827) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 75bda9957ea872ab71fbfa63c8f4d57e2458afb6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 75bda9957ea872ab71fbfa63c8f4d57e2458afb6 --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=923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-09 04:34:00,353 truncating revision to first 12 chars 2017-02-09 04:34:00,353 Setting DEBUG logging. 2017-02-09 04:34:00,353 attempt 1/10 2017-02-09 04:34:00,353 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/75bda9957ea8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 04:34:01,604 unpacking tar archive at: mozilla-aurora-75bda9957ea8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.564885 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 04:34:01.806438) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 04:34:01.806773) ========= script_repo_revision: 75bda9957ea872ab71fbfa63c8f4d57e2458afb6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 04:34:01.807135) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 04:34:01.807397) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 04:34:01.815730) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-02-09 04:34:01.816058) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-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', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-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=923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:34:02 INFO - MultiFileLogger online at 20170209 04:34:02 in /builds/slave/test 04:34:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 04:34:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:34:02 INFO - {'append_to_log': False, 04:34:02 INFO - 'base_work_dir': '/builds/slave/test', 04:34:02 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 04:34:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:34:02 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 04:34:02 INFO - 'buildbot_json_path': 'buildprops.json', 04:34:02 INFO - 'config_files': ('talos/linux_config.py',), 04:34:02 INFO - 'default_actions': ('clobber', 04:34:02 INFO - 'read-buildbot-config', 04:34:02 INFO - 'download-and-extract', 04:34:02 INFO - 'populate-webroot', 04:34:02 INFO - 'create-virtualenv', 04:34:02 INFO - 'install', 04:34:02 INFO - 'run-tests'), 04:34:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:34:02 INFO - 'download_minidump_stackwalk': True, 04:34:02 INFO - 'download_symbols': 'ondemand', 04:34:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:34:02 INFO - 'tooltool.py': '/tools/tooltool.py', 04:34:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:34:02 INFO - '/tools/misc-python/virtualenv.py')}, 04:34:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:34:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:34:02 INFO - 'installer_path': 'installer.exe', 04:34:02 INFO - 'log_level': 'info', 04:34:02 INFO - 'log_name': 'talos', 04:34:02 INFO - 'log_to_console': True, 04:34:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:34:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:34:02 INFO - 'opt_config_files': (), 04:34:02 INFO - 'pip_index': False, 04:34:02 INFO - 'sps_profile': False, 04:34:02 INFO - 'sps_profile_interval': 0, 04:34:02 INFO - 'suite': 'dromaeojs-e10s', 04:34:02 INFO - 'system_bits': '32', 04:34:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:34:02 INFO - 'title': 'talos-linux64-ix-007', 04:34:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:34:02 INFO - 'use_talos_json': True, 04:34:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:34:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:34:02 INFO - 'work_dir': 'build'} 04:34:02 INFO - [mozharness: 2017-02-09 12:34:02.047735Z] Running clobber step. 04:34:02 INFO - Running pre-action listener: _resource_record_pre_action 04:34:02 INFO - Running main action method: clobber 04:34:02 INFO - rmtree: /builds/slave/test/build 04:34:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:34:02 INFO - Running post-action listener: _resource_record_post_action 04:34:02 INFO - [mozharness: 2017-02-09 12:34:02.575280Z] Finished clobber step (success) 04:34:02 INFO - [mozharness: 2017-02-09 12:34:02.575381Z] Running read-buildbot-config step. 04:34:02 INFO - Running pre-action listener: _resource_record_pre_action 04:34:02 INFO - Running main action method: read_buildbot_config 04:34:02 INFO - Using buildbot properties: 04:34:02 INFO - { 04:34:02 INFO - "project": "", 04:34:02 INFO - "product": "firefox", 04:34:02 INFO - "who": "archaeopteryx@coole-files.de", 04:34:02 INFO - "installer_path": "public/build/target.tar.bz2", 04:34:02 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 04:34:02 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 04:34:02 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs-e10s", 04:34:02 INFO - "stage_platform": "linux64", 04:34:02 INFO - "basedir": "/builds/slave/test", 04:34:02 INFO - "buildnumber": 23, 04:34:02 INFO - "platform": "ubuntu64_hw", 04:34:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:34:02 INFO - "slavebuilddir": "test", 04:34:02 INFO - "taskId": "O7pRxpJ2SaGYdpEh0QV8lw", 04:34:02 INFO - "branch": "mozilla-aurora", 04:34:02 INFO - "script_repo_revision": "production", 04:34:02 INFO - "revision": "75bda9957ea872ab71fbfa63c8f4d57e2458afb6", 04:34:02 INFO - "slavename": "talos-linux64-ix-007", 04:34:02 INFO - "repo_path": "releases/mozilla-aurora" 04:34:02 INFO - } 04:34:02 INFO - Finding installer, test and symbols from parent task. 04:34:02 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O7pRxpJ2SaGYdpEh0QV8lw'}, attempt #1 04:34:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O7pRxpJ2SaGYdpEh0QV8lw'}, attempt #1 04:34:03 INFO - Task dependencies: W34yO6bSTL-mVmlMyGW8LA 04:34:03 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA'}, attempt #1 04:34:03 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/target.tar.bz2 04:34:03 INFO - Set test_url: https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/test_packages.json 04:34:03 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/target.crashreporter-symbols.zip 04:34:03 INFO - Running post-action listener: _resource_record_post_action 04:34:03 INFO - [mozharness: 2017-02-09 12:34:03.996977Z] Finished read-buildbot-config step (success) 04:34:03 INFO - [mozharness: 2017-02-09 12:34:03.997200Z] Running download-and-extract step. 04:34:03 INFO - Running pre-action listener: _resource_record_pre_action 04:34:03 INFO - Running main action method: download_and_extract 04:34:03 INFO - mkdir: /builds/slave/test/build/tests 04:34:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:34:03 INFO - trying https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/target.test_packages.json 04:34:03 INFO - Downloading https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:34:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:34:04 INFO - Downloaded 896 bytes. 04:34:04 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:34:04 INFO - Using the following test package requirements: 04:34:04 INFO - {u'common': [u'target.common.tests.zip'], 04:34:04 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:34:04 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:34:04 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:34:04 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:34:04 INFO - u'mozbase': [u'target.common.tests.zip'], 04:34:04 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:34:04 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:34:04 INFO - u'web-platform': [u'target.common.tests.zip', 04:34:04 INFO - u'target.web-platform.tests.zip'], 04:34:04 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:34:04 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:34:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/target.common.tests.zip 04:34:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:34:04 INFO - Fetch https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/target.common.tests.zip into memory 04:34:05 INFO - Expected file size: 21859219 04:34:05 INFO - Obtained file size: 21859219 04:34:09 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:34:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/target.common.tests.zip 04:34:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:34:09 INFO - Fetch https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/target.common.tests.zip into memory 04:34:10 INFO - Expected file size: 21859219 04:34:10 INFO - Obtained file size: 21859219 04:34:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/target.talos.tests.zip 04:34:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:34:14 INFO - Fetch https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/target.talos.tests.zip into memory 04:34:15 INFO - Expected file size: 14403485 04:34:15 INFO - Obtained file size: 14403485 04:34:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:34:15 INFO - trying https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/target.tar.bz2 04:34:15 INFO - Downloading https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:34:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:34:16 INFO - Downloaded 66010938 bytes. 04:34:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/target.tar.bz2 04:34:16 INFO - mkdir: /builds/slave/test/properties 04:34:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:34:16 INFO - Writing to file /builds/slave/test/properties/build_url 04:34:16 INFO - Contents: 04:34:16 INFO - build_url:https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/target.tar.bz2 04:34:16 INFO - Running post-action listener: _resource_record_post_action 04:34:16 INFO - Running post-action listener: set_extra_try_arguments 04:34:16 INFO - [mozharness: 2017-02-09 12:34:16.954965Z] Finished download-and-extract step (success) 04:34:16 INFO - [mozharness: 2017-02-09 12:34:16.955095Z] Running populate-webroot step. 04:34:16 INFO - Running pre-action listener: _resource_record_pre_action 04:34:16 INFO - Running main action method: populate_webroot 04:34:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:34:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:34:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:34:16 INFO - '--tppagecycles', 04:34:16 INFO - '7'], 04:34:16 INFO - 'tests': ['tsvgm']}}, 04:34:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:34:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:34:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:34:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:34:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:34:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:34:16 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:34:16 INFO - 'talos_options': ['--disable-e10s'], 04:34:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:34:16 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:34:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:34:16 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:34:16 INFO - 'talos_options': ['--disable-e10s'], 04:34:16 INFO - 'tests': ['damp', 'tps']}, 04:34:16 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:34:16 INFO - 'tests': ['damp', 'tps']}, 04:34:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:34:16 INFO - 'tests': ['dromaeo_dom']}, 04:34:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:34:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:34:16 INFO - 'tests': ['basic_compositor_video']}, 04:34:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:34:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:34:16 INFO - 'tests': ['a11yr', 04:34:16 INFO - 'ts_paint', 04:34:16 INFO - 'tpaint', 04:34:16 INFO - 'sessionrestore', 04:34:16 INFO - 'sessionrestore_no_auto_restore', 04:34:16 INFO - 'tabpaint']}, 04:34:16 INFO - 'other-e10s': {'tests': ['a11yr', 04:34:16 INFO - 'ts_paint', 04:34:16 INFO - 'tpaint', 04:34:16 INFO - 'sessionrestore', 04:34:16 INFO - 'sessionrestore_no_auto_restore', 04:34:16 INFO - 'tabpaint']}, 04:34:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:34:16 INFO - 'ts_paint', 04:34:16 INFO - 'tpaint', 04:34:16 INFO - 'sessionrestore', 04:34:16 INFO - 'sessionrestore_no_auto_restore', 04:34:16 INFO - 'tabpaint']}, 04:34:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:34:16 INFO - 'ts_paint', 04:34:16 INFO - 'tpaint', 04:34:16 INFO - 'sessionrestore', 04:34:16 INFO - 'sessionrestore_no_auto_restore', 04:34:16 INFO - 'tabpaint']}, 04:34:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:34:16 INFO - 'tests': ['a11yr', 04:34:16 INFO - 'ts_paint', 04:34:16 INFO - 'tpaint', 04:34:16 INFO - 'sessionrestore', 04:34:16 INFO - 'sessionrestore_no_auto_restore', 04:34:16 INFO - 'tabpaint']}, 04:34:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:34:16 INFO - 'tests': ['a11yr', 04:34:16 INFO - 'ts_paint', 04:34:16 INFO - 'tpaint', 04:34:16 INFO - 'sessionrestore', 04:34:16 INFO - 'sessionrestore_no_auto_restore', 04:34:16 INFO - 'tabpaint']}, 04:34:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:34:16 INFO - 'tests': ['tsvgx', 04:34:16 INFO - 'tsvgr_opacity', 04:34:16 INFO - 'tart', 04:34:16 INFO - 'tscrollx', 04:34:16 INFO - 'cart', 04:34:16 INFO - 'tsvg_static']}, 04:34:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:34:16 INFO - 'tsvgr_opacity', 04:34:16 INFO - 'tart', 04:34:16 INFO - 'tscrollx', 04:34:16 INFO - 'cart', 04:34:16 INFO - 'tsvg_static']}, 04:34:16 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:34:16 INFO - 'talos_options': ['--disable-e10s'], 04:34:16 INFO - 'tests': ['tp5o']}, 04:34:16 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:34:16 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:34:16 INFO - 'talos_options': ['--disable-e10s', 04:34:16 INFO - '--xperf_path', 04:34:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:34:16 INFO - 'tests': ['tp5n']}, 04:34:16 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:34:16 INFO - 'talos_options': ['--xperf_path', 04:34:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:34:16 INFO - 'tests': ['tp5n']}}, 04:34:16 INFO - 'talos.zip': {'path': '', 04:34:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:34:16 INFO - Running post-action listener: _resource_record_post_action 04:34:16 INFO - [mozharness: 2017-02-09 12:34:16.969991Z] Finished populate-webroot step (success) 04:34:16 INFO - [mozharness: 2017-02-09 12:34:16.970081Z] Running create-virtualenv step. 04:34:16 INFO - Running pre-action listener: _resource_record_pre_action 04:34:16 INFO - Running main action method: create_virtualenv 04:34:16 INFO - Creating virtualenv /builds/slave/test/build/venv 04:34:16 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 04:34:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:34:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:34:17 INFO - Using real prefix '/usr' 04:34:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:34:17 INFO - Installing distribute.............................................................................................................................................................................................done. 04:34:19 INFO - Installing pip.................done. 04:34:19 INFO - Return code: 0 04:34:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:34:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:34:19 INFO - Reading from file tmpfile_stdout 04:34:19 INFO - Output received: 04:34:19 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) 04:34:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:34:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:34:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x19951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d07980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d04d00>, '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 0x1d05a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d05eb0>, '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': '923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871', '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 04:34:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:34:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:34:19 INFO - Using env: {'DISPLAY': ':0', 04:34:19 INFO - 'HOME': '/home/cltbld', 04:34:19 INFO - 'LANG': 'en_US.UTF-8', 04:34:19 INFO - 'LANGUAGE': 'en_US:en', 04:34:19 INFO - 'LOGNAME': 'cltbld', 04:34:19 INFO - 'MAIL': '/var/mail/cltbld', 04:34:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:19 INFO - 'MOZ_NO_REMOTE': '1', 04:34:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:19 INFO - 'NO_EM_RESTART': '1', 04:34:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:19 INFO - 'PWD': '/builds/slave/test', 04:34:19 INFO - 'SHELL': '/bin/bash', 04:34:19 INFO - 'SHLVL': '1', 04:34:19 INFO - 'TERM': 'linux', 04:34:19 INFO - 'TMOUT': '86400', 04:34:19 INFO - 'USER': 'cltbld', 04:34:19 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871', 04:34:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:19 INFO - '_': '/tools/buildbot/bin/python'} 04:34:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:19 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 04:34:19 INFO - Cleaning up... 04:34:20 INFO - Return code: 0 04:34:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:34:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:34:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x19951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d07980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d04d00>, '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 0x1d05a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d05eb0>, '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': '923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871', '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 04:34:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:34:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:34:20 INFO - Using env: {'DISPLAY': ':0', 04:34:20 INFO - 'HOME': '/home/cltbld', 04:34:20 INFO - 'LANG': 'en_US.UTF-8', 04:34:20 INFO - 'LANGUAGE': 'en_US:en', 04:34:20 INFO - 'LOGNAME': 'cltbld', 04:34:20 INFO - 'MAIL': '/var/mail/cltbld', 04:34:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:20 INFO - 'MOZ_NO_REMOTE': '1', 04:34:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:20 INFO - 'NO_EM_RESTART': '1', 04:34:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:20 INFO - 'PWD': '/builds/slave/test', 04:34:20 INFO - 'SHELL': '/bin/bash', 04:34:20 INFO - 'SHLVL': '1', 04:34:20 INFO - 'TERM': 'linux', 04:34:20 INFO - 'TMOUT': '86400', 04:34:20 INFO - 'USER': 'cltbld', 04:34:20 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871', 04:34:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:20 INFO - '_': '/tools/buildbot/bin/python'} 04:34:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:20 INFO - Downloading/unpacking psutil>=3.1.1 04:34:20 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 04:34:20 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 04:34:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:20 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 04:34:20 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 04:34:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:34:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:34:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:34:22 INFO - Installing collected packages: psutil 04:34:22 INFO - Running setup.py install for psutil 04:34:22 INFO - building 'psutil._psutil_linux' extension 04:34:22 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 04:34:22 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 04:34:22 INFO - building 'psutil._psutil_posix' extension 04:34:22 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 04:34:22 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 04:34:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:34:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:34:22 INFO - Successfully installed psutil 04:34:22 INFO - Cleaning up... 04:34:22 INFO - Return code: 0 04:34:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:34:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:34:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:22 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x19951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d07980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d04d00>, '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 0x1d05a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d05eb0>, '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': '923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871', '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 04:34:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:34:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:34:22 INFO - Using env: {'DISPLAY': ':0', 04:34:22 INFO - 'HOME': '/home/cltbld', 04:34:22 INFO - 'LANG': 'en_US.UTF-8', 04:34:22 INFO - 'LANGUAGE': 'en_US:en', 04:34:22 INFO - 'LOGNAME': 'cltbld', 04:34:22 INFO - 'MAIL': '/var/mail/cltbld', 04:34:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:22 INFO - 'MOZ_NO_REMOTE': '1', 04:34:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:22 INFO - 'NO_EM_RESTART': '1', 04:34:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:22 INFO - 'PWD': '/builds/slave/test', 04:34:22 INFO - 'SHELL': '/bin/bash', 04:34:22 INFO - 'SHLVL': '1', 04:34:22 INFO - 'TERM': 'linux', 04:34:22 INFO - 'TMOUT': '86400', 04:34:22 INFO - 'USER': 'cltbld', 04:34:22 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871', 04:34:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:22 INFO - '_': '/tools/buildbot/bin/python'} 04:34:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:34:23 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 04:34:23 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 04:34:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:23 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 04:34:23 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 04:34:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:34:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:34:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:34:25 INFO - Installing collected packages: mozsystemmonitor 04:34:25 INFO - Running setup.py install for mozsystemmonitor 04:34:25 INFO - Successfully installed mozsystemmonitor 04:34:25 INFO - Cleaning up... 04:34:25 INFO - Return code: 0 04:34:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:25 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x19951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d07980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d04d00>, '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 0x1d05a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d05eb0>, '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': '923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871', '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 04:34:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:34:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:34:25 INFO - Using env: {'DISPLAY': ':0', 04:34:25 INFO - 'HOME': '/home/cltbld', 04:34:25 INFO - 'LANG': 'en_US.UTF-8', 04:34:25 INFO - 'LANGUAGE': 'en_US:en', 04:34:25 INFO - 'LOGNAME': 'cltbld', 04:34:25 INFO - 'MAIL': '/var/mail/cltbld', 04:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:25 INFO - 'MOZ_NO_REMOTE': '1', 04:34:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:25 INFO - 'NO_EM_RESTART': '1', 04:34:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:25 INFO - 'PWD': '/builds/slave/test', 04:34:25 INFO - 'SHELL': '/bin/bash', 04:34:25 INFO - 'SHLVL': '1', 04:34:25 INFO - 'TERM': 'linux', 04:34:25 INFO - 'TMOUT': '86400', 04:34:25 INFO - 'USER': 'cltbld', 04:34:25 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871', 04:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:25 INFO - '_': '/tools/buildbot/bin/python'} 04:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:25 INFO - Downloading/unpacking jsonschema==2.5.1 04:34:25 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 04:34:25 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 04:34:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:25 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 04:34:25 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 04:34:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:34:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:34:27 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 04:34:27 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 04:34:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:27 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 04:34:27 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 04:34:27 INFO - Downloading functools32-3.2.3-2.tar.gz 04:34:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:34:27 INFO - warning: no files found matching '*.txt' 04:34:27 INFO - no previously-included directories found matching 'build' 04:34:27 INFO - no previously-included directories found matching 'dist' 04:34:27 INFO - no previously-included directories found matching '.git*' 04:34:27 INFO - Installing collected packages: jsonschema, functools32 04:34:27 INFO - Running setup.py install for functools32 04:34:28 INFO - warning: no files found matching '*.txt' 04:34:28 INFO - no previously-included directories found matching 'build' 04:34:28 INFO - no previously-included directories found matching 'dist' 04:34:28 INFO - no previously-included directories found matching '.git*' 04:34:28 INFO - Successfully installed jsonschema functools32 04:34:28 INFO - Cleaning up... 04:34:28 INFO - Return code: 0 04:34:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:28 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x19951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d07980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d04d00>, '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 0x1d05a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d05eb0>, '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': '923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871', '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 04:34:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:34:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:34:28 INFO - Using env: {'DISPLAY': ':0', 04:34:28 INFO - 'HOME': '/home/cltbld', 04:34:28 INFO - 'LANG': 'en_US.UTF-8', 04:34:28 INFO - 'LANGUAGE': 'en_US:en', 04:34:28 INFO - 'LOGNAME': 'cltbld', 04:34:28 INFO - 'MAIL': '/var/mail/cltbld', 04:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:28 INFO - 'MOZ_NO_REMOTE': '1', 04:34:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:28 INFO - 'NO_EM_RESTART': '1', 04:34:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:28 INFO - 'PWD': '/builds/slave/test', 04:34:28 INFO - 'SHELL': '/bin/bash', 04:34:28 INFO - 'SHLVL': '1', 04:34:28 INFO - 'TERM': 'linux', 04:34:28 INFO - 'TMOUT': '86400', 04:34:28 INFO - 'USER': 'cltbld', 04:34:28 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871', 04:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:28 INFO - '_': '/tools/buildbot/bin/python'} 04:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:34:28 INFO - Cleaning up... 04:34:28 INFO - Return code: 0 04:34:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:28 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x19951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d07980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d04d00>, '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 0x1d05a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d05eb0>, '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': '923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871', '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 04:34:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:34:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:34:28 INFO - Using env: {'DISPLAY': ':0', 04:34:28 INFO - 'HOME': '/home/cltbld', 04:34:28 INFO - 'LANG': 'en_US.UTF-8', 04:34:28 INFO - 'LANGUAGE': 'en_US:en', 04:34:28 INFO - 'LOGNAME': 'cltbld', 04:34:28 INFO - 'MAIL': '/var/mail/cltbld', 04:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:28 INFO - 'MOZ_NO_REMOTE': '1', 04:34:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:28 INFO - 'NO_EM_RESTART': '1', 04:34:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:28 INFO - 'PWD': '/builds/slave/test', 04:34:28 INFO - 'SHELL': '/bin/bash', 04:34:28 INFO - 'SHLVL': '1', 04:34:28 INFO - 'TERM': 'linux', 04:34:28 INFO - 'TMOUT': '86400', 04:34:28 INFO - 'USER': 'cltbld', 04:34:28 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871', 04:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:28 INFO - '_': '/tools/buildbot/bin/python'} 04:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:28 INFO - Downloading/unpacking blobuploader==1.2.4 04:34:28 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 04:34:28 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 04:34:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:28 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 04:34:28 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 04:34:30 INFO - Downloading blobuploader-1.2.4.tar.gz 04:34:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:34:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:34:30 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 04:34:30 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 04:34:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:30 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 04:34:30 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 04:34:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:34:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:34:31 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 04:34:31 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 04:34:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:31 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 04:34:31 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 04:34:31 INFO - Downloading docopt-0.6.1.tar.gz 04:34:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:34:31 INFO - Installing collected packages: blobuploader, requests, docopt 04:34:31 INFO - Running setup.py install for blobuploader 04:34:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:34:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:34:31 INFO - Running setup.py install for requests 04:34:31 INFO - Running setup.py install for docopt 04:34:31 INFO - Successfully installed blobuploader requests docopt 04:34:31 INFO - Cleaning up... 04:34:31 INFO - Return code: 0 04:34:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:34:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:34:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:32 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x19951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d07980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d04d00>, '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 0x1d05a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d05eb0>, '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': '923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871', '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 04:34:32 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:34:32 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:34:32 INFO - Using env: {'DISPLAY': ':0', 04:34:32 INFO - 'HOME': '/home/cltbld', 04:34:32 INFO - 'LANG': 'en_US.UTF-8', 04:34:32 INFO - 'LANGUAGE': 'en_US:en', 04:34:32 INFO - 'LOGNAME': 'cltbld', 04:34:32 INFO - 'MAIL': '/var/mail/cltbld', 04:34:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:32 INFO - 'MOZ_NO_REMOTE': '1', 04:34:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:32 INFO - 'NO_EM_RESTART': '1', 04:34:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:32 INFO - 'PWD': '/builds/slave/test', 04:34:32 INFO - 'SHELL': '/bin/bash', 04:34:32 INFO - 'SHLVL': '1', 04:34:32 INFO - 'TERM': 'linux', 04:34:32 INFO - 'TMOUT': '86400', 04:34:32 INFO - 'USER': 'cltbld', 04:34:32 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871', 04:34:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:32 INFO - '_': '/tools/buildbot/bin/python'} 04:34:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:34:32 INFO - Running setup.py (path:/tmp/pip-Int7PM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:34:32 INFO - Running setup.py (path:/tmp/pip-JeCFYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:34:32 INFO - Running setup.py (path:/tmp/pip-SYCgiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:34:32 INFO - Running setup.py (path:/tmp/pip-GrKqrL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:34:32 INFO - Running setup.py (path:/tmp/pip-6NG6qZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:34:32 INFO - Running setup.py (path:/tmp/pip-usQCjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:34:32 INFO - Running setup.py (path:/tmp/pip-KyCwP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:34:32 INFO - Running setup.py (path:/tmp/pip-maN5NJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:34:32 INFO - Running setup.py (path:/tmp/pip-3_5YS2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:34:32 INFO - Running setup.py (path:/tmp/pip-4QbgCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:34:32 INFO - Running setup.py (path:/tmp/pip-gXqqzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:34:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:34:32 INFO - Running setup.py (path:/tmp/pip-Q4lLzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:34:33 INFO - Running setup.py (path:/tmp/pip-SICgdl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:34:33 INFO - Running setup.py (path:/tmp/pip-SxzeEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:33 INFO - Running setup.py (path:/tmp/pip-CHA3UP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:34:33 INFO - Running setup.py (path:/tmp/pip-HX545X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:34:33 INFO - Running setup.py (path:/tmp/pip-oZLeJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:34:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:34:33 INFO - Running setup.py install for manifestparser 04:34:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:34:33 INFO - Running setup.py install for mozcrash 04:34:33 INFO - Running setup.py install for mozdebug 04:34:33 INFO - Running setup.py install for mozdevice 04:34:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:34:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:34:33 INFO - Running setup.py install for mozfile 04:34:33 INFO - Running setup.py install for mozhttpd 04:34:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:34:34 INFO - Running setup.py install for mozinfo 04:34:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:34:34 INFO - Running setup.py install for mozInstall 04:34:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:34:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:34:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:34:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:34:34 INFO - Running setup.py install for mozleak 04:34:34 INFO - Running setup.py install for mozlog 04:34:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:34:34 INFO - Running setup.py install for moznetwork 04:34:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:34:34 INFO - Running setup.py install for mozprocess 04:34:34 INFO - Running setup.py install for mozprofile 04:34:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:34:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:34:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:34:34 INFO - Running setup.py install for mozrunner 04:34:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:34:34 INFO - Running setup.py install for mozscreenshot 04:34:34 INFO - Running setup.py install for moztest 04:34:35 INFO - Running setup.py install for mozversion 04:34:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:34:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:34:35 INFO - Cleaning up... 04:34:35 INFO - Return code: 0 04:34:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:34:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:34:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:35 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x19951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d07980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d04d00>, '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 0x1d05a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d05eb0>, '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': '923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871', '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 04:34:35 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:34:35 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:34:35 INFO - Using env: {'DISPLAY': ':0', 04:34:35 INFO - 'HOME': '/home/cltbld', 04:34:35 INFO - 'LANG': 'en_US.UTF-8', 04:34:35 INFO - 'LANGUAGE': 'en_US:en', 04:34:35 INFO - 'LOGNAME': 'cltbld', 04:34:35 INFO - 'MAIL': '/var/mail/cltbld', 04:34:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:35 INFO - 'MOZ_NO_REMOTE': '1', 04:34:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:35 INFO - 'NO_EM_RESTART': '1', 04:34:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:35 INFO - 'PWD': '/builds/slave/test', 04:34:35 INFO - 'SHELL': '/bin/bash', 04:34:35 INFO - 'SHLVL': '1', 04:34:35 INFO - 'TERM': 'linux', 04:34:35 INFO - 'TMOUT': '86400', 04:34:35 INFO - 'USER': 'cltbld', 04:34:35 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871', 04:34:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:35 INFO - '_': '/tools/buildbot/bin/python'} 04:34:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:34:35 INFO - Running setup.py (path:/tmp/pip-CuQ7Uv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:34:35 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)) 04:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:34:35 INFO - Running setup.py (path:/tmp/pip-TIQ8Hn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:34:35 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)) 04:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:34:35 INFO - Running setup.py (path:/tmp/pip-pG1Enk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:34:35 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)) 04:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:34:35 INFO - Running setup.py (path:/tmp/pip-DA1Zmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:34:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 04:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:34:35 INFO - Running setup.py (path:/tmp/pip-MrYHku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:34:35 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)) 04:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:34:35 INFO - Running setup.py (path:/tmp/pip-hoyRgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:34:35 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)) 04:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:34:35 INFO - Running setup.py (path:/tmp/pip-IAJ_ug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:34:35 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)) 04:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:34:35 INFO - Running setup.py (path:/tmp/pip-QwzHwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:34:36 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)) 04:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:34:36 INFO - Running setup.py (path:/tmp/pip-G2bClf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:34:36 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)) 04:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:34:36 INFO - Running setup.py (path:/tmp/pip-R4Ff6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:34:36 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)) 04:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:34:36 INFO - Running setup.py (path:/tmp/pip-FDdd8f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:34:36 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)) 04:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:34:36 INFO - Running setup.py (path:/tmp/pip-p5DEXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:34:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 04:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:34:36 INFO - Running setup.py (path:/tmp/pip-0nRmZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:34:36 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)) 04:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:34:36 INFO - Running setup.py (path:/tmp/pip-Qw6LPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:34:36 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)) 04:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:36 INFO - Running setup.py (path:/tmp/pip-YJ6Lc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:36 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)) 04:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:34:36 INFO - Running setup.py (path:/tmp/pip-1YTs09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:34:36 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)) 04:34:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:34:36 INFO - Running setup.py (path:/tmp/pip-Wbfp0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:34:36 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)) 04:34:36 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)) 04:34:36 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)) 04:34:36 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)) 04:34:36 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:34:36 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:34:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:34:36 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 04:34:36 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 04:34:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:36 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 04:34:36 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 04:34:38 INFO - Downloading blessings-1.6.tar.gz 04:34:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:34:38 INFO - Installing collected packages: blessings 04:34:38 INFO - Running setup.py install for blessings 04:34:38 INFO - Successfully installed blessings 04:34:38 INFO - Cleaning up... 04:34:38 INFO - Return code: 0 04:34:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:34:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:34:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:34:39 INFO - Reading from file tmpfile_stdout 04:34:39 INFO - Current package versions: 04:34:39 INFO - argparse == 1.2.1 04:34:39 INFO - blessings == 1.6 04:34:39 INFO - blobuploader == 1.2.4 04:34:39 INFO - docopt == 0.6.1 04:34:39 INFO - functools32 == 3.2.3-2 04:34:39 INFO - jsonschema == 2.5.1 04:34:39 INFO - manifestparser == 1.1 04:34:39 INFO - mozInstall == 1.12 04:34:39 INFO - mozcrash == 1.0 04:34:39 INFO - mozdebug == 0.1 04:34:39 INFO - mozdevice == 0.49 04:34:39 INFO - mozfile == 1.2 04:34:39 INFO - mozhttpd == 0.7 04:34:39 INFO - mozinfo == 0.9 04:34:39 INFO - mozleak == 0.1 04:34:39 INFO - mozlog == 3.4 04:34:39 INFO - moznetwork == 0.27 04:34:39 INFO - mozprocess == 0.24 04:34:39 INFO - mozprofile == 0.28 04:34:39 INFO - mozrunner == 6.13 04:34:39 INFO - mozscreenshot == 0.1 04:34:39 INFO - mozsystemmonitor == 0.3 04:34:39 INFO - moztest == 0.8 04:34:39 INFO - mozversion == 1.4 04:34:39 INFO - psutil == 3.1.1 04:34:39 INFO - requests == 1.2.3 04:34:39 INFO - wsgiref == 0.1.2 04:34:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:34:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:39 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x19951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d07980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d04d00>, '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 0x1d05a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d05eb0>, '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': '923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871', '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 04:34:39 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 04:34:39 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.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:34:39 INFO - Using env: {'DISPLAY': ':0', 04:34:39 INFO - 'HOME': '/home/cltbld', 04:34:39 INFO - 'LANG': 'en_US.UTF-8', 04:34:39 INFO - 'LANGUAGE': 'en_US:en', 04:34:39 INFO - 'LOGNAME': 'cltbld', 04:34:39 INFO - 'MAIL': '/var/mail/cltbld', 04:34:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:39 INFO - 'MOZ_NO_REMOTE': '1', 04:34:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:39 INFO - 'NO_EM_RESTART': '1', 04:34:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:39 INFO - 'PWD': '/builds/slave/test', 04:34:39 INFO - 'SHELL': '/bin/bash', 04:34:39 INFO - 'SHLVL': '1', 04:34:39 INFO - 'TERM': 'linux', 04:34:39 INFO - 'TMOUT': '86400', 04:34:39 INFO - 'USER': 'cltbld', 04:34:39 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871', 04:34:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:39 INFO - '_': '/tools/buildbot/bin/python'} 04:34:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:39 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)) 04:34:39 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)) 04:34:39 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)) 04:34:39 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)) 04:34:39 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)) 04:34:39 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)) 04:34:39 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)) 04:34:39 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)) 04:34:39 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)) 04:34:39 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)) 04:34:39 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)) 04:34:39 INFO - Cleaning up... 04:34:39 INFO - Return code: 0 04:34:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:34:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:34:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:34:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:39 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.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--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 0x19951f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b62a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d07980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d04d00>, '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 0x1d05a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d05eb0>, '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': '923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871', '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 04:34:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:34:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:34:39 INFO - Using env: {'DISPLAY': ':0', 04:34:39 INFO - 'HOME': '/home/cltbld', 04:34:39 INFO - 'LANG': 'en_US.UTF-8', 04:34:39 INFO - 'LANGUAGE': 'en_US:en', 04:34:39 INFO - 'LOGNAME': 'cltbld', 04:34:39 INFO - 'MAIL': '/var/mail/cltbld', 04:34:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:39 INFO - 'MOZ_NO_REMOTE': '1', 04:34:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:39 INFO - 'NO_EM_RESTART': '1', 04:34:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:39 INFO - 'PWD': '/builds/slave/test', 04:34:39 INFO - 'SHELL': '/bin/bash', 04:34:39 INFO - 'SHLVL': '1', 04:34:39 INFO - 'TERM': 'linux', 04:34:39 INFO - 'TMOUT': '86400', 04:34:39 INFO - 'USER': 'cltbld', 04:34:39 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871', 04:34:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:39 INFO - '_': '/tools/buildbot/bin/python'} 04:34:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:34:39 INFO - Cleaning up... 04:34:39 INFO - Return code: 0 04:34:39 INFO - Running post-action listener: _resource_record_post_action 04:34:39 INFO - Running post-action listener: _start_resource_monitoring 04:34:39 INFO - Starting resource monitoring. 04:34:39 INFO - [mozharness: 2017-02-09 12:34:39.685215Z] Finished create-virtualenv step (success) 04:34:39 INFO - [mozharness: 2017-02-09 12:34:39.685663Z] Running install step. 04:34:39 INFO - Running pre-action listener: _resource_record_pre_action 04:34:39 INFO - Running main action method: install 04:34:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:34:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:34:39 INFO - Reading from file tmpfile_stdout 04:34:39 INFO - Detecting whether we're running mozinstall >=1.0... 04:34:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:34:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:34:39 INFO - Reading from file tmpfile_stdout 04:34:39 INFO - Output received: 04:34:39 INFO - Usage: mozinstall [options] installer 04:34:39 INFO - Options: 04:34:39 INFO - -h, --help show this help message and exit 04:34:39 INFO - -d DEST, --destination=DEST 04:34:39 INFO - Directory to install application into. [default: 04:34:39 INFO - "/builds/slave/test"] 04:34:39 INFO - --app=APP Application being installed. [default: firefox] 04:34:39 INFO - mkdir: /builds/slave/test/build/application 04:34:39 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'] 04:34:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:34:56 INFO - Reading from file tmpfile_stdout 04:34:56 INFO - Output received: 04:34:56 INFO - /builds/slave/test/build/application/firefox/firefox 04:34:56 INFO - Running post-action listener: _resource_record_post_action 04:34:56 INFO - [mozharness: 2017-02-09 12:34:56.420239Z] Finished install step (success) 04:34:56 INFO - [mozharness: 2017-02-09 12:34:56.420511Z] Running run-tests step. 04:34:56 INFO - Running pre-action listener: _resource_record_pre_action 04:34:56 INFO - Running main action method: run_tests 04:34:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:34:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:34:56 INFO - Python 2.7.3 04:34:56 INFO - Return code: 0 04:34:56 INFO - grabbing minidump binary from tooltool 04:34:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.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')]} 04:34:56 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 0x1d04d00>, '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 0x1d05a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d05eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:34:56 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 04:34:56 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 04:34:56 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 04:34:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:34:56 INFO - Return code: 0 04:34:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:34:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:34:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:34:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:34:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:34:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 04:34:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 04:34:56 INFO - Using env: {'DISPLAY': ':0', 04:34:56 INFO - 'HOME': '/home/cltbld', 04:34:56 INFO - 'LANG': 'en_US.UTF-8', 04:34:56 INFO - 'LANGUAGE': 'en_US:en', 04:34:56 INFO - 'LOGNAME': 'cltbld', 04:34:56 INFO - 'MAIL': '/var/mail/cltbld', 04:34:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:34:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:34:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:56 INFO - 'MOZ_NO_REMOTE': '1', 04:34:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:34:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:34:56 INFO - 'NO_EM_RESTART': '1', 04:34:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:34:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:56 INFO - 'PWD': '/builds/slave/test', 04:34:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:34:56 INFO - 'SHELL': '/bin/bash', 04:34:56 INFO - 'SHLVL': '1', 04:34:56 INFO - 'TERM': 'linux', 04:34:56 INFO - 'TMOUT': '86400', 04:34:56 INFO - 'USER': 'cltbld', 04:34:56 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871', 04:34:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:56 INFO - '_': '/tools/buildbot/bin/python'} 04:34:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 04:34:56 INFO - mozversion application_buildid: 20170209113607 04:34:56 INFO - mozversion application_changeset: 75bda9957ea872ab71fbfa63c8f4d57e2458afb6 04:34:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 04:34:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:34:56 INFO - mozversion application_name: Firefox 04:34:56 INFO - mozversion application_remotingname: firefox-dev 04:34:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:34:56 INFO - mozversion application_vendor: Mozilla 04:34:56 INFO - mozversion application_version: 53.0a2 04:34:56 INFO - mozversion platform_buildid: 20170209113607 04:34:56 INFO - mozversion platform_changeset: 75bda9957ea872ab71fbfa63c8f4d57e2458afb6 04:34:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 04:34:56 INFO - mozversion platform_version: 53.0a2 04:34:56 INFO - using testdate: 1486643696 04:34:56 INFO - actual date: 1486643696 04:34:56 INFO - starting webserver on 'localhost:57334' 04:34:56 INFO - SUITE-START | Running 2 tests 04:34:56 INFO - TEST-START | dromaeo_css 04:34:56 INFO - operating with platform_type : linux_ 04:34:56 INFO - Initialising browser for dromaeo_css test... 04:34:56 INFO - TEST-INFO | started process 27756 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmABxI5/profile http://localhost:57334/getInfo.html) 04:35:00 INFO - PROCESS | 27756 | __metrics Screen width/height:1600/1200 04:35:00 INFO - PROCESS | 27756 | colorDepth:24 04:35:00 INFO - PROCESS | 27756 | Browser inner width/height: 1024/697 04:35:00 INFO - PROCESS | 27756 | __metrics 04:35:01 INFO - PROCESS | 27756 | 1486643701043 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmpmABxI5/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpmABxI5/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpmABxI5/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpmABxI5/profile/extensions/talos-powers@TalosPowersService.js:55:9 04:35:01 ERROR - PROCESS | 27756 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 04:35:01 INFO - TEST-INFO | 27756: exit 0 04:35:01 INFO - Browser initialized. 04:35:01 INFO - Running cycle 1/1 for dromaeo_css test... 04:35:01 INFO - TEST-INFO | started process 27883 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmABxI5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:35:13 INFO - PROCESS | 27883 | RSS: Main: 145022976 04:35:13 INFO - PROCESS | 27883 | 04:38:12 INFO - PROCESS | 27883 | Cycle 1(1): loaded http://localhost:57334/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57334/tests/dromaeo/cssquery-ext.html) 04:38:13 INFO - PROCESS | 27883 | RSS: Main: 152440832 04:38:13 INFO - PROCESS | 27883 | 04:40:02 INFO - PROCESS | 27883 | ************************* 04:40:02 INFO - PROCESS | 27883 | A coding exception was thrown and uncaught in a Task. 04:40:02 INFO - PROCESS | 27883 | 04:40:02 ERROR - PROCESS | 27883 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:40:02 INFO - PROCESS | 27883 | Full stack: 04:40:02 INFO - PROCESS | 27883 | ************************* 04:41:15 INFO - PROCESS | 27883 | Cycle 1(1): loaded http://localhost:57334/tests/dromaeo/cssquery-ext.html (next: http://localhost:57334/tests/dromaeo/cssquery-jquery.html) 04:41:16 INFO - PROCESS | 27883 | RSS: Main: 151924736 04:41:16 INFO - PROCESS | 27883 | 04:44:18 INFO - PROCESS | 27883 | Cycle 1(1): loaded http://localhost:57334/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57334/tests/dromaeo/cssquery-mootools.html) 04:44:18 INFO - PROCESS | 27883 | RSS: Main: 155062272 04:44:18 INFO - PROCESS | 27883 | 04:47:20 INFO - PROCESS | 27883 | Cycle 1(1): loaded http://localhost:57334/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57334/tests/dromaeo/cssquery-prototype.html) 04:47:21 INFO - PROCESS | 27883 | RSS: Main: 149839872 04:47:21 INFO - PROCESS | 27883 | 04:50:23 INFO - PROCESS | 27883 | Cycle 1(1): loaded http://localhost:57334/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57334/tests/dromaeo/cssquery-yui.html) 04:50:24 INFO - PROCESS | 27883 | RSS: Main: 153341952 04:50:24 INFO - PROCESS | 27883 | 04:53:26 INFO - PROCESS | 27883 | Cycle 1(1): loaded http://localhost:57334/tests/dromaeo/cssquery-yui.html (next: http://localhost:57334/tests/dromaeo/cssquery-dojo.html) 04:53:26 INFO - PROCESS | 27883 | RSS: Main: 154673152 04:53:26 INFO - PROCESS | 27883 | 04:53:26 INFO - PROCESS | 27883 | __start_tp_report 04:53:26 INFO - PROCESS | 27883 | _x_x_mozilla_page_load 04:53:26 INFO - PROCESS | 27883 | _x_x_mozilla_page_load_details 04:53:26 INFO - PROCESS | 27883 | |i|pagename|runs| 04:53:26 INFO - PROCESS | 27883 | |0;dojo.html;3236.8867089651867;3260.168656992468;3280.0651814232947;3283.1463819406945;3285.5728755261825;5338.89322213556;5393.164059570763;5428.104362780142;5433.347998240207;5472.945270547293;5431.266778984836;5482.259894914186;5483.7806487740445;5496;5506.559475241981;4906.803727850882;4922.581580565657;4947.505249475042;4964.801407943678;4987.102321582114;4932.728699921503;4985.052839960414;5002.074616195997;5002.624803139761;5019.874503137433;4823.686460380064;4852.223644216926;4964.826231081913;4994.051130285234;5036.949630503703;4838.854834354993;4857.319975203474;4933.777979990909;4956.653034287601;4958.851234462972;4927.679700819471;4931.482194369575;4941.604671626297;4948.604111671094;4963.6277279204205;5379.300690910196;5381.19282107687;5394.541463975567;5471.835844924619;5471.972640136813;5689.971550142222;5716.028275193227;5738.024535828919;5775.711214439261;5797;5893.44012318829;5914.2902851657645;5922.940770592282;5926.703664816742;5931.377205393414;5527.695976721278;5534.972325138348;5535.142052981794;5543.8891222175735;5552.805651802168;5767.85580360486;5817.214676018768;5839.883202335929;5972.25346831646;6006.069059295816;5647.915281270784;5668.26312579362;5709.600327977002;5749.540036797046;5777.30672319316;5780.88438231233;5783;5836.445537673914;5842.707864606838;5851.736671849777;5529.889402211933;5823.417658234227;5826.126081087786;5829;5837.532997360201;5637.26715526987;5706.087026075808;5725.169850371756;5745.195672605755;5816.243888294579;4491.752953587584;4504.09918016398;4505.189065968091;4519;4538.11506756186;3961.207758448322;3985.740926839746;3988.3818008208773;4014.3175660137263;4021.7586944783407;5515.917261241085;5535.58483113768;5550.8057217997175;5564.137558678412;5574.247476590689;5851.297844258716;5851.824445266649;5856.355800861902;5890.764369425261;5916.585838991229;5479.917801232985;5521.475459831309;5530.668159910338;5613.943860561424;5681.261436013292;4873.829415970424;4967;4982.103221420107;4982.900341993212;4986.700797952134;6020.367861374581;6054.697265136726;6059.969700151471;6082.847928801727;6085.66528840918;5618.410066943075;5648.068068768607;5806.65160090396;5838.854028649148;5858.150568167677;5909.261342332208;5917.644941303535;5920.200772895776;5924.111383292368;5932.0508718604815;5609.4390560943575;5617.32592088952;5684.204211410323;5691;5772.163036359789;5823.534117270693;5828.679422631626;5829.09649004405;5836.591438599427;5844.064949608042;5557.5831812613405;5644.955683198621;5661.915071273852;5694.117411801178;5710.5717071219;5525.392206857323;5560.165975103767;5560.443955604407;5597.188407680945;5673.461021202979;5637.041702910597;5646.153077038477;5657.26455560791;5670.149477578396;5674.4892959633835;5639.3232812062815;5676.120201368794;5683.829485115453;5713.942860571341;5715.142728590745;5483.670979741229;5544.140658197985;5545.445455454423;5575.581831362583;5584.46947539983 04:53:26 INFO - PROCESS | 27883 | |1;ext.html;545.2676429837759;601.7171929193279;614.0880792023843;695.7112798188751;718.2637796258831;43804.342934856;44858.775706121465;47808.760956195256;47899.281510777364;48168.75915620426;48616.75691621537;49765.502344976536;50070.49929500713;50224.748876255566;50236.49763502364;9144.95427522863;10675.19936004799;11002.614908478205;11057.889421105767;11421.25761825483;10866.891331086706;10916.399598022106;10978.560857565688;11030.06244469221;11050;11075.944620276927;11099.278546894466;11117.833232501518;11125.443727813617;11176.497057632427;11047.392393418359;11049.447527623586;11082.833757493645;11089.722756931102;11091.445427728662;10926.726831829188;11012.614558490415;11032.338059716443;11060.502277397536;11076.39079850608;42523.78738106321;42596.787016065035;42930.14139717188;43131.13737725259;43172.78413607912;4443.866683999485;4458.1306645204195;4495.820167193308;4607.677462577621;4614.72311661298;31618.209544761336;31661.36677266465;32141.839290803397;32540;33066;4238.295924409253;4501.594856462902;4530.977345113286;4552.52198519154;4568.0407114506;207739;210120;210516;210943;211645;62911;62992.370076299565;63260.683696581225;63293;63377;65466;65527.67236163789;65605;65817;65839.67080164568;18523.44429667112;18706.625867482573;19029.333973310866;19384.80615193858;19459.31892383788;14349.928250358682;14388.496402625859;14468;14490.710185796224;14533.563993080224;19855.205791768458;20350.28773992903;20382.388528344174;20426.38720838377;20516.38450846477;7363.447741419415;7649.655765490566;7683.5774032427635;7733.265339792711;7917.802054948557;988.1304452082265;989.7624570103268;1013.9695809125737;1019.3679918450608;1039.4750650921237;33402.832985835405;33516.49725254123;33568;33769;33935.32129357399;1101.779644071189;1137.0960086731068;1145.4593571646124;1164.831099490586;1180.2682336951145;17450.825491745174;17457.301707931794;17532.29870805179;17640.735388969177;17739.911300443415;538048;556519;560593;565191;845857;62346;62469.68765156236;62543.6872815633;62842.37157628457;63318.68340658267;1526.5801904476136;1553.3786485405928;1556.820965588949;1562.5859147325968;1570.3718512594826;31312;31396.68603314029;31427.84286078555;31713.841430792698;32407.027789166365;53586.73206634098;54472.182917257065;54611.45388546223;54709.452905472026;54738.72630636821;493328;494882;496300;497172;498727;28834;28979.710202897702;29690.703092968793;29987.70012299849;31904.840475798403;48076.5192348072;48087.51912480831;48378.274325885846;48928.75535622299;49009;41701.1659766809;42593;42608.1478370437;43020;43182;39569.406458903715;39843;41019.1796164081;41268.79365603153;41770.16459670729;38118;39441.211175776894;40053.59946400499;41167.588324117576;41337.58662413337;33954;35282.11794705153;35363;35644.46533302055;35895.82052089723;27241.727582723917;27539.862300688368;27664.58503122495;27705.44589108247;27772.166834994983 04:53:26 INFO - PROCESS | 27883 | |2;jquery.html;418.31605325293134;429.4974879391112;432.5628613886152;434.6349066783901;438.56801050964805;19795.208191672333;21742.565148697016;21862;22815.31554053381;23047.423814404647;22755.203567875127;22920.197793077245;23067;23198.420039499022;23357.299281021555;6096.939030609704;6150.477209437203;6287.497000239992;6335.239771227459;6337.271213810402;6064;6193.6283822970545;6194.318624951252;6194.349593292707;6198.4731297839735;5934.258217722785;6115.816525504242;6135.417135372155;6168.96915515424;6170.784022559212;6046.12331211974;6121.571489995702;6170;6173.351798061184;6181.5672902896595;5360.973195133999;5535.335759708821;5543.805966791183;5568.49883510486;5590.692511911843;25693.871530642227;25874;26001.089961851245;26079.73920260811;26135.73864261352;3225.3388055448577;3357.4795906634513;3372.898813035613;3401.0817079388426;3425.0409885232175;15796.605084872856;15906.52280431589;16080.276387562588;16116.194190290438;16502.2573984171;1966.5575245569776;1991.3229501969256;1997.4007797660788;1999.2003198720483;2010.2361102780997;89992.55003725005;91533;91568.08431915662;92446.53776731073;93832.53083734537;11875.40622968848;12308.815367769312;12470;12826.486940522274;12828.166169198972;17063.573410664834;17105.657886842193;17148.82851171497;17201.1399430028;17238.569035774206;9394.62421503146;9487.146156845916;9616.182624476858;9693.515324233902;9758.268129890286;9381.343305968654;9405.247580193569;9418.152366287068;9449.43303401798;9713.320067595341;7750;7825.843483130306;7861.292483676382;7917.564533950573;7956.403269754792;2041.4386043838063;2096.371088673392;2120.480482281851;2162.924297649606;2201.218567408579;1160.3502038858267;1179.4692388425242;1188.518649946773;1190.6487586162102;1196.5333519927235;19313.324033658755;20023.39929802079;20848.687269690967;20894.164233430492;20955.057022434026;1172.202902026613;1176.1766763265748;1181.3797756177903;1186.2170967161633;1208.3173007250875;11352;11870.584529541424;11967.64097077089;12021.398930053638;12032.217905836093;618286;626345;663286;669425;709271;85248;85955;86471.56764216139;87772.5611371939;88841;1105.3036586950332;1112.2158877990996;1114.4205013393153;1117.5697356517799;1129.271619805221;17787.73318400251;18115.54711132232;18162.364317248834;18172.45482635523;18583.53541161482;42332.36501452419;42531.57468425276;42660.360094597985;43042.35436468393;43421.13157736765;56144.438555615554;56486;56924.43075569357;57490.13764793615;57662.13506797485;8369.49783013021;8608.98685460084;8836.160564746338;8867.0689577596;9058.456492610465;8419.284360829153;13229.544750077292;13643.727125457634;13779.104358216684;14637.840746590733;11919.821202681793;12657.87342126567;12671.303078330411;12739.681507962005;12900.29048402347;11736.178467507534;12112.939435302767;12587.433565489759;12673.465306938464;12813.679658008625;11808.763824723286;12755.107142499935;12859.871401285867;12914.935425322814;13042.673933151367;9641.710748677551;9768.658096966572;9794.461304628314;9795.9020409795;9970.800583988135;10032.64885728996;12662.556810511587;12742.362881855684;12785.16896401731;13048.151870128411 04:53:26 INFO - PROCESS | 27883 | |3;mootools.html;1458.5405597236877;1472.9631759206018;1475.7048590281947;1480.2450750117441;1483.110133919648;7557.24427557244;7797.337226335754;8011.759647210586;8489.278411335044;8491;8096.068952070514;8270.297024752888;8345.332373410129;8517.53153576553;8524.232819046285;2364.125273648748;2405.747396523366;2412.1075202175134;2417.456072383717;2423.430493833948;2314.6296592545195;2330.650402439631;2335.1126571902737;2341.6370462578243;2343.273585188597;2355.0697474497647;2370.0401337458356;2371.3597328721235;2378.7621237876247;2400.1719406804714;2285.3486756274465;2292.106078629336;2306.8961896714686;2316.8030717388956;2318.976810231893;2285.097386532327;2335.427820184049;2337.4740683346113;2348.38941875112;2375.10933399975;8398.622062007224;8429.789255268606;8433.367497437717;8474.364422668325;8478.576071196416;5015.348004759395;5241.056609810233;5316.202569614588;5332.066888294533;5345.812896548641;3190.5692731481186;3278.1804548862783;3352.513885486615;3380.408428525023;3393.100828280483;1379.0622376783783;1379.5999160243518;1406.0298394108136;1415.2216281045385;1448.6016345504966;10474.26680132391;10541;10546;10585.206109541816;10621.41582212978;4535.115652447807;4566.474855391606;4636.35091087248;4712.481627021093;4739.526047395302;9752.024797520333;9816.460094694861;9826.213902887752;9857.11285984265;9860.654877079267;5415.891682166334;5416.241726158341;5417.133258678593;5417.945820541744;5422.349318081855;4348.826046958086;4756.571908528249;4792.592629626521;4863.2461968394955;4904.509549045067;4010.498687664042;4068.3694027425795;4075.1034772350035;4146.813393397304;4147.19129769692;1341.0076543357845;1342.812006319116;1353.6954185308227;1357.6673714939902;1360.5646193218074;950.9762255943657;982.9311948163703;989.1888651306004;998.1715176403568;1019.4545917934018;5480.369757477862;5721.914171287434;5758.74085666146;5781.19063331134;5807.419258074159;635.3487675133026;635.5519358851998;641.4804008752925;646.1954866191621;657.552864052449;3794.829232684536;3842.9231415371537;3851.7111216658864;3860.189360234382;3875.2443273561385;9828.655997040069;10181.389116653025;10191.133753631024;10210.13213876814;10216.029477199654;10053.949730251303;10113.443760593238;10117.747056323651;10126.39241645489;10127.493625318704;7406.925930740624;7969.481983671043;8023.679052837938;8030.598470076473;8052.758417247492;5104.923426148685;5116.053530096944;5151.0470562945975;5176.1200595898035;5247.055530004636;9102.135297147026;9156.862647060432;9157.908420915972;9196.862047069433;9213.12475314844;9219.86170207434;9348.25213982866;9365.203957663674;9435.198008169107;9473.100055494717;7576.052993375828;7706.922930770845;7807.336376408069;7955.363570914429;8025.398095142771;8035.236652518001;8319.168083191633;8319.792005199677;8334.791630209293;8347.040090389683;7183.353498185188;7219.0976127984;7259.6007219603425;7270.0886644665625;7659;7100.751473698396;7259.854802903807;7387.741429049957;7426.405887529093;7457.515261508202;6405.615663060231;6499.447546958561;6762.323767623198;6805.421539169028;6839.281875403011;4561.817527298871;4567.497575266651;4761;4814.446338670958;4951.9257211142585;4818.759062046814;4829.106615276185;4830.734309613005;4882.023595281029;5034.798608055783 04:53:26 INFO - PROCESS | 27883 | |4;prototype.html;397.77923252594815;398.4202984657323;409.4533797380497;412.57916924736753;415.46405137372807;5322.680639161644;5401.918971215435;5440.918386224205;5478.096114141167;5515.172724091383;5154.098032844256;5274.92087618686;5277.076511610472;5350.652207606503;5382.865428364293;4287.121140166266;4293.355996600504;4312.792418122931;4320.719153255029;4348.652107831382;4176.290030694774;4230.16578892143;4230.534641189467;4251.278232315917;4302.26861433557;4193;4196.832126714943;4215.894602634928;4223.788810559459;4241.257779888522;4248.447701798762;4255.340422234543;4259;4266.616004559604;4285.957140428587;3702.3520883845217;3713.4801127842125;3735.383661695817;3772.5661548921953;3806.162644218295;5285.656432331886;5314.811113332009;5318.175682769177;5323.459899167088;5354;4929.507049295078;4940.827071052496;4946.233333833262;4955.5044495550155;4976.850694479172;5700.857478563028;5711.742971566289;5715.771369145229;5741.712914354265;5770.134479828017;4193.832246710128;4198.467559340818;4201.957980420218;4211;4216.3464662976985;5778.451047150514;5890.4698577128265;5934.703264836741;5947.524198064188;6002.819915402545;4257.765822879709;4311.935320970188;4312.396264522969;4318.589733975267;4331.7834108294455;4381.561843815657;4399.340098985178;4401.691881568324;4404.757738324359;4426.667999899956;4852.320675105488;4932.284818701268;4998.300237966688;5013.799448022039;5044.924326135111;5778.88442231153;5780;5788.131780232999;5791.420857914175;5831.183634291203;1456.1627064437992;1461.729580027677;1465.7288401645517;1469.5297504798361;1474.2039298778539;986.240594742059;996.3075662414552;1018.2973748113777;1028.7068185567077;1032.865727455441;5524.364698059694;5548.9722551386985;5549.833504994856;5552.556335352838;5562.692767199705;5796.913046304308;5798.057650686983;5804;5806.82579522615;5872.588918775645;5273.947260527422;5472.699001554953;5493.917591236134;5526.640768350125;5562.916556251659;3020.365723198153;3020.622422197225;3035.195673146618;3042.710942460463;3046.7562594992346;5733.312002559636;5903.144044113666;5923.970380148072;5977.6114552553945;6047.758089676364;5952.345242023374;6006;6033.978617163211;6044.909326360108;6084.482818960438;6069.180660610849;6110.236220472441;6120.296165940974;6188.2883468400805;6200.875982480326;5613.354464236665;5915.171875937458;5919.556033297606;5936.406359364029;5941.287045554561;5850.853728656818;5918.704064796657;5922.2597175353085;5948.226730525004;5965.940340596712;5860.208871802422;6076.878462430638;6097.817065488042;6119.3268740437625;6244.188255526752;4249;4292.283086765319;4310.504292006334;4311.461067366579;4311.935320970125;5758.222639943554;5900.813560677187;5903.527717782653;5935.643861368331;5936.931352356444;5743.10981797822;5746.454086861741;5756.7409466574945;5782.884342313214;5786.450287222707;5755.280589926259;5768.365479797135;5775.33583637887;5802.738876750472;5823.563232757476;5461.399246082849;5695.914561281501;5729.140628905531;5754.884902302014;5755.194272801895;5777.104548794943;5801.477866991991;5809.448102430262;5838.737256823369;5865.44565690101;5530.349969020588;5714.485696287354;5719.456651618089;5723.570732195185;5745.368009519033 04:53:26 INFO - PROCESS | 27883 | |5;yui.html;828.0708040348551;846.8518009348362;858.2104463893218;939.126612250607;958.3818437108064;16169.272382742776;17281.82718172818;17514.649707005854;18131.365402210926;18335.449936501893;15828.920855395736;15929.92035039826;16256.268467918942;16712.41506547268;16931.83068169318;841.8442588121187;857.2841677199546;858.6822875536029;859.2095272349453;860.6471346747835;834.3408707121367;857.8884744983144;858.935579831512;860.2859626509982;862.1637012098286;880.2210044110976;895.7671005538574;896.9372143949926;901.4636291406603;904.9502277374742;894.9463032218088;900.7162743735735;902.165496915354;902.2511315608095;903.1735961595166;657.4083325007483;657.4444594317794;658.993410065898;659.6273105695267;661.2362721057139;17361.7395739064;17582.29670813166;17807;17843.10784460772;17888.91055544727;16484.670306593922;16634.58413539659;16704.74942875858;16766.41317553892;17104.57238569033;13536.59390218295;13689.452421903112;13726.313684315744;13761.655958601015;14003.299835008209;4006.3389540725743;4051.108756073659;4063.553009168989;4064;4070.063885306396;85984.57007714984;86413;87172;87918.12081879227;89588;12803;12993.876893329149;13042.347882605833;13068.54260100892;13180.681931806934;24247.600415117195;24519;24582.754172458404;24661.136860210165;24738.628920566207;8875.955620221857;8903.955480222687;9016.819663606691;9132.589033493508;9164.358494905426;4985.426675932242;5038;5050.772715227824;5059.443461219263;5145.845624631267;3669.7798132112157;3762.6613604775703;3765.811709414573;3767.472553842464;3768.1333293342686;647.9546431749826;650.2749434380631;654.0810161722787;660.8975608780647;673.0678010954765;799.2407213147533;814.4950130918868;825.2468062552407;840.306746933782;842.1999100854091;10960.671179864617;11189.272697274651;11235;11461.842171022907;11809.23239989398;670.7987603718963;672.0658284983876;686.5811854768588;688.7589343729654;696.6377483708544;5145.742712864342;5416;5436.864078398072;5525.585581081355;5535.833924982257;86204.56897715472;86590;86897.56551217203;86999.56500217458;87601.12398876058;75622;75826.62086689532;77082;77567.61216193996;78137.21862781413;66655.66672166705;68191;69431.65284173547;69611.3038869615;69702;10276.743081423025;10329;10426;10629.734256643645;10641.361518308617;42013.57986420097;43712.56287437085;44223.557764421945;44668.55331446644;45225.77387113175;55030;55412.72293638506;57539.71230143822;57669.711651443155;58390.7080464595;13662.658433538843;14159.150450972975;14179.14925104497;14212;14372.928135359256;14996.250187490363;14998;15019.399224030916;15092.54722358331;15408.383664653289;13414.798778018532;13828.08858386769;14040.157590544191;14098.577042688736;14491;14255.287235637968;14291.714165716836;14468.710625787637;14684.706305874037;15007.399704011717;13640.727185456433;13780.724385512434;13960.79058814139;14083.014189006672;14290.714185716019;10399.1160751337;10530.684079477627;10598.04617584421;10702.250842441266;10905.400202988912;9767.658131965347;10464.476776161313;10482.423466709404;10508.684739457829;10555.472226388496 04:53:26 INFO - PROCESS | 27883 | __end_tp_report 04:53:26 INFO - PROCESS | 27883 | __start_cc_report 04:53:26 INFO - PROCESS | 27883 | _x_x_mozilla_cycle_collect,312 04:53:26 INFO - PROCESS | 27883 | __end_cc_report 04:53:26 INFO - PROCESS | 27883 | __startTimestamp1486644806792__endTimestamp 04:53:26 INFO - PROCESS | 27883 | 04:53:26 INFO - PROCESS | 27883 | ------- Summary: start ------- 04:53:26 INFO - PROCESS | 27883 | Number of tests: 6 04:53:26 INFO - PROCESS | 27883 | 04:53:26 INFO - PROCESS | 27883 | [#0] dojo.html Cycles:165 Average:5400.86 Median:5584.47 stddev:589.94 (10.6%) stddev-sans-first:566.80 04:53:26 INFO - PROCESS | 27883 | Values: 3236.9 3260.2 3280.1 3283.1 3285.6 5338.9 5393.2 5428.1 5433.3 5472.9 5431.3 5482.3 5483.8 5496.0 5506.6 4906.8 4922.6 4947.5 4964.8 4987.1 4932.7 4985.1 5002.1 5002.6 5019.9 4823.7 4852.2 4964.8 4994.1 5036.9 4838.9 4857.3 4933.8 4956.7 4958.9 4927.7 4931.5 4941.6 4948.6 4963.6 5379.3 5381.2 5394.5 5471.8 5472.0 5690.0 5716.0 5738.0 5775.7 5797.0 5893.4 5914.3 5922.9 5926.7 5931.4 5527.7 5535.0 5535.1 5543.9 5552.8 5767.9 5817.2 5839.9 5972.3 6006.1 5647.9 5668.3 5709.6 5749.5 5777.3 5780.9 5783.0 5836.4 5842.7 5851.7 5529.9 5823.4 5826.1 5829.0 5837.5 5637.3 5706.1 5725.2 5745.2 5816.2 4491.8 4504.1 4505.2 4519.0 4538.1 3961.2 3985.7 3988.4 4014.3 4021.8 5515.9 5535.6 5550.8 5564.1 5574.2 5851.3 5851.8 5856.4 5890.8 5916.6 5479.9 5521.5 5530.7 5613.9 5681.3 4873.8 4967.0 4982.1 4982.9 4986.7 6020.4 6054.7 6060.0 6082.8 6085.7 5618.4 5648.1 5806.7 5838.9 5858.2 5909.3 5917.6 5920.2 5924.1 5932.1 5609.4 5617.3 5684.2 5691.0 5772.2 5823.5 5828.7 5829.1 5836.6 5844.1 5557.6 5645.0 5661.9 5694.1 5710.6 5525.4 5560.2 5560.4 5597.2 5673.5 5637.0 5646.2 5657.3 5670.1 5674.5 5639.3 5676.1 5683.8 5713.9 5715.1 5483.7 5544.1 5545.4 5575.6 5584.5 04:53:26 INFO - PROCESS | 27883 | 04:53:26 INFO - PROCESS | 27883 | [#1] ext.html Cycles:180 Average:61495.58 Median:35770.14 stddev:127392.34 (356.1%) stddev-sans-first:127667.52 04:53:26 INFO - PROCESS | 27883 | Values: 545.3 601.7 614.1 695.7 718.3 43804.3 44858.8 47808.8 47899.3 48168.8 48616.8 49765.5 50070.5 50224.7 50236.5 9145.0 10675.2 11002.6 11057.9 11421.3 10866.9 10916.4 10978.6 11030.1 11050.0 11075.9 11099.3 11117.8 11125.4 11176.5 11047.4 11049.4 11082.8 11089.7 11091.4 10926.7 11012.6 11032.3 11060.5 11076.4 42523.8 42596.8 42930.1 43131.1 43172.8 4443.9 4458.1 4495.8 4607.7 4614.7 31618.2 31661.4 32141.8 32540.0 33066.0 4238.3 4501.6 4531.0 4552.5 4568.0 207739.0 210120.0 210516.0 210943.0 211645.0 62911.0 62992.4 63260.7 63293.0 63377.0 65466.0 65527.7 65605.0 65817.0 65839.7 18523.4 18706.6 19029.3 19384.8 19459.3 14349.9 14388.5 14468.0 14490.7 14533.6 19855.2 20350.3 20382.4 20426.4 20516.4 7363.4 7649.7 7683.6 7733.3 7917.8 988.1 989.8 1014.0 1019.4 1039.5 33402.8 33516.5 33568.0 33769.0 33935.3 1101.8 1137.1 1145.5 1164.8 1180.3 17450.8 17457.3 17532.3 17640.7 17739.9 538048.0 556519.0 560593.0 565191.0 845857.0 62346.0 62469.7 62543.7 62842.4 63318.7 1526.6 1553.4 1556.8 1562.6 1570.4 31312.0 31396.7 31427.8 31713.8 32407.0 53586.7 54472.2 54611.5 54709.5 54738.7 493328.0 494882.0 496300.0 497172.0 498727.0 28834.0 28979.7 29690.7 29987.7 31904.8 48076.5 48087.5 48378.3 48928.8 49009.0 41701.2 42593.0 42608.1 43020.0 43182.0 39569.4 39843.0 41019.2 41268.8 41770.2 38118.0 39441.2 40053.6 41167.6 41337.6 33954.0 35282.1 35363.0 35644.5 35895.8 27241.7 27539.9 27664.6 27705.4 27772.2 04:53:26 INFO - PROCESS | 27883 | 04:53:26 INFO - PROCESS | 27883 | [#2] jquery.html Cycles:180 Average:34790.04 Median:25937.54 stddev:107709.80 (415.3%) stddev-sans-first:107981.03 04:53:26 INFO - PROCESS | 27883 | Values: 418.3 429.5 432.6 434.6 438.6 19795.2 21742.6 21862.0 22815.3 23047.4 22755.2 22920.2 23067.0 23198.4 23357.3 6096.9 6150.5 6287.5 6335.2 6337.3 6064.0 6193.6 6194.3 6194.3 6198.5 5934.3 6115.8 6135.4 6169.0 6170.8 6046.1 6121.6 6170.0 6173.4 6181.6 5361.0 5535.3 5543.8 5568.5 5590.7 25693.9 25874.0 26001.1 26079.7 26135.7 3225.3 3357.5 3372.9 3401.1 3425.0 15796.6 15906.5 16080.3 16116.2 16502.3 1966.6 1991.3 1997.4 1999.2 2010.2 89992.6 91533.0 91568.1 92446.5 93832.5 11875.4 12308.8 12470.0 12826.5 12828.2 17063.6 17105.7 17148.8 17201.1 17238.6 9394.6 9487.1 9616.2 9693.5 9758.3 9381.3 9405.2 9418.2 9449.4 9713.3 7750.0 7825.8 7861.3 7917.6 7956.4 2041.4 2096.4 2120.5 2162.9 2201.2 1160.4 1179.5 1188.5 1190.6 1196.5 19313.3 20023.4 20848.7 20894.2 20955.1 1172.2 1176.2 1181.4 1186.2 1208.3 11352.0 11870.6 11967.6 12021.4 12032.2 618286.0 626345.0 663286.0 669425.0 709271.0 85248.0 85955.0 86471.6 87772.6 88841.0 1105.3 1112.2 1114.4 1117.6 1129.3 17787.7 18115.5 18162.4 18172.5 18583.5 42332.4 42531.6 42660.4 43042.4 43421.1 56144.4 56486.0 56924.4 57490.1 57662.1 8369.5 8609.0 8836.2 8867.1 9058.5 8419.3 13229.5 13643.7 13779.1 14637.8 11919.8 12657.9 12671.3 12739.7 12900.3 11736.2 12112.9 12587.4 12673.5 12813.7 11808.8 12755.1 12859.9 12914.9 13042.7 9641.7 9768.7 9794.5 9795.9 9970.8 10032.6 12662.6 12742.4 12785.2 13048.2 04:53:26 INFO - PROCESS | 27883 | 04:53:26 INFO - PROCESS | 27883 | [#3] mootools.html Cycles:180 Average:5518.96 Median:5069.86 stddev:2997.43 (59.1%) stddev-sans-first:2990.30 04:53:26 INFO - PROCESS | 27883 | Values: 1458.5 1473.0 1475.7 1480.2 1483.1 7557.2 7797.3 8011.8 8489.3 8491.0 8096.1 8270.3 8345.3 8517.5 8524.2 2364.1 2405.7 2412.1 2417.5 2423.4 2314.6 2330.7 2335.1 2341.6 2343.3 2355.1 2370.0 2371.4 2378.8 2400.2 2285.3 2292.1 2306.9 2316.8 2319.0 2285.1 2335.4 2337.5 2348.4 2375.1 8398.6 8429.8 8433.4 8474.4 8478.6 5015.3 5241.1 5316.2 5332.1 5345.8 3190.6 3278.2 3352.5 3380.4 3393.1 1379.1 1379.6 1406.0 1415.2 1448.6 10474.3 10541.0 10546.0 10585.2 10621.4 4535.1 4566.5 4636.4 4712.5 4739.5 9752.0 9816.5 9826.2 9857.1 9860.7 5415.9 5416.2 5417.1 5417.9 5422.3 4348.8 4756.6 4792.6 4863.2 4904.5 4010.5 4068.4 4075.1 4146.8 4147.2 1341.0 1342.8 1353.7 1357.7 1360.6 951.0 982.9 989.2 998.2 1019.5 5480.4 5721.9 5758.7 5781.2 5807.4 635.3 635.6 641.5 646.2 657.6 3794.8 3842.9 3851.7 3860.2 3875.2 9828.7 10181.4 10191.1 10210.1 10216.0 10053.9 10113.4 10117.7 10126.4 10127.5 7406.9 7969.5 8023.7 8030.6 8052.8 5104.9 5116.1 5151.0 5176.1 5247.1 9102.1 9156.9 9157.9 9196.9 9213.1 9219.9 9348.3 9365.2 9435.2 9473.1 7576.1 7706.9 7807.3 7955.4 8025.4 8035.2 8319.2 8319.8 8334.8 8347.0 7183.4 7219.1 7259.6 7270.1 7659.0 7100.8 7259.9 7387.7 7426.4 7457.5 6405.6 6499.4 6762.3 6805.4 6839.3 4561.8 4567.5 4761.0 4814.4 4951.9 4818.8 4829.1 4830.7 4882.0 5034.8 04:53:26 INFO - PROCESS | 27883 | 04:53:26 INFO - PROCESS | 27883 | [#4] prototype.html Cycles:180 Average:4852.34 Median:5504.55 stddev:1413.47 (25.7%) stddev-sans-first:1377.33 04:53:26 INFO - PROCESS | 27883 | Values: 397.8 398.4 409.5 412.6 415.5 5322.7 5401.9 5440.9 5478.1 5515.2 5154.1 5274.9 5277.1 5350.7 5382.9 4287.1 4293.4 4312.8 4320.7 4348.7 4176.3 4230.2 4230.5 4251.3 4302.3 4193.0 4196.8 4215.9 4223.8 4241.3 4248.4 4255.3 4259.0 4266.6 4286.0 3702.4 3713.5 3735.4 3772.6 3806.2 5285.7 5314.8 5318.2 5323.5 5354.0 4929.5 4940.8 4946.2 4955.5 4976.9 5700.9 5711.7 5715.8 5741.7 5770.1 4193.8 4198.5 4202.0 4211.0 4216.3 5778.5 5890.5 5934.7 5947.5 6002.8 4257.8 4311.9 4312.4 4318.6 4331.8 4381.6 4399.3 4401.7 4404.8 4426.7 4852.3 4932.3 4998.3 5013.8 5044.9 5778.9 5780.0 5788.1 5791.4 5831.2 1456.2 1461.7 1465.7 1469.5 1474.2 986.2 996.3 1018.3 1028.7 1032.9 5524.4 5549.0 5549.8 5552.6 5562.7 5796.9 5798.1 5804.0 5806.8 5872.6 5273.9 5472.7 5493.9 5526.6 5562.9 3020.4 3020.6 3035.2 3042.7 3046.8 5733.3 5903.1 5924.0 5977.6 6047.8 5952.3 6006.0 6034.0 6044.9 6084.5 6069.2 6110.2 6120.3 6188.3 6200.9 5613.4 5915.2 5919.6 5936.4 5941.3 5850.9 5918.7 5922.3 5948.2 5965.9 5860.2 6076.9 6097.8 6119.3 6244.2 4249.0 4292.3 4310.5 4311.5 4311.9 5758.2 5900.8 5903.5 5935.6 5936.9 5743.1 5746.5 5756.7 5782.9 5786.5 5755.3 5768.4 5775.3 5802.7 5823.6 5461.4 5695.9 5729.1 5754.9 5755.2 5777.1 5801.5 5809.4 5838.7 5865.4 5530.3 5714.5 5719.5 5723.6 5745.4 04:53:26 INFO - PROCESS | 27883 | 04:53:26 INFO - PROCESS | 27883 | [#5] yui.html Cycles:180 Average:19142.90 Median:43968.06 stddev:24549.91 (55.8%) stddev-sans-first:24580.26 04:53:26 INFO - PROCESS | 27883 | Values: 828.1 846.9 858.2 939.1 958.4 16169.3 17281.8 17514.6 18131.4 18335.4 15828.9 15929.9 16256.3 16712.4 16931.8 841.8 857.3 858.7 859.2 860.6 834.3 857.9 858.9 860.3 862.2 880.2 895.8 896.9 901.5 905.0 894.9 900.7 902.2 902.3 903.2 657.4 657.4 659.0 659.6 661.2 17361.7 17582.3 17807.0 17843.1 17888.9 16484.7 16634.6 16704.7 16766.4 17104.6 13536.6 13689.5 13726.3 13761.7 14003.3 4006.3 4051.1 4063.6 4064.0 4070.1 85984.6 86413.0 87172.0 87918.1 89588.0 12803.0 12993.9 13042.3 13068.5 13180.7 24247.6 24519.0 24582.8 24661.1 24738.6 8876.0 8904.0 9016.8 9132.6 9164.4 4985.4 5038.0 5050.8 5059.4 5145.8 3669.8 3762.7 3765.8 3767.5 3768.1 648.0 650.3 654.1 660.9 673.1 799.2 814.5 825.2 840.3 842.2 10960.7 11189.3 11235.0 11461.8 11809.2 670.8 672.1 686.6 688.8 696.6 5145.7 5416.0 5436.9 5525.6 5535.8 86204.6 86590.0 86897.6 86999.6 87601.1 75622.0 75826.6 77082.0 77567.6 78137.2 66655.7 68191.0 69431.7 69611.3 69702.0 10276.7 10329.0 10426.0 10629.7 10641.4 42013.6 43712.6 44223.6 44668.6 45225.8 55030.0 55412.7 57539.7 57669.7 58390.7 13662.7 14159.2 14179.1 14212.0 14372.9 14996.3 14998.0 15019.4 15092.5 15408.4 13414.8 13828.1 14040.2 14098.6 14491.0 14255.3 14291.7 14468.7 14684.7 15007.4 13640.7 13780.7 13960.8 14083.0 14290.7 10399.1 10530.7 10598.0 10702.3 10905.4 9767.7 10464.5 10482.4 10508.7 10555.5 04:53:26 INFO - PROCESS | 27883 | -------- Summary: end -------- 04:53:26 INFO - PROCESS | 27883 | 04:53:27 INFO - TEST-INFO | 27883: exit 0 04:53:27 INFO - TEST-OK | dromaeo_css | took 1110849ms 04:53:27 INFO - TEST-START | kraken 04:53:27 INFO - operating with platform_type : linux_ 04:53:27 INFO - Initialising browser for kraken test... 04:53:27 INFO - TEST-INFO | started process 28257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp41Ra5j/profile http://localhost:57334/getInfo.html) 04:53:31 INFO - PROCESS | 28257 | __metrics Screen width/height:1600/1200 04:53:31 INFO - PROCESS | 28257 | colorDepth:24 04:53:31 INFO - PROCESS | 28257 | Browser inner width/height: 1024/697 04:53:31 INFO - PROCESS | 28257 | __metrics 04:53:31 INFO - PROCESS | 28257 | 1486644811956 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmp41Ra5j/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmp41Ra5j/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmp41Ra5j/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmp41Ra5j/profile/extensions/talos-powers@TalosPowersService.js:55:9 04:53:32 ERROR - PROCESS | 28257 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 04:53:32 INFO - TEST-INFO | 28257: exit 0 04:53:32 INFO - Browser initialized. 04:53:32 INFO - Running cycle 1/1 for kraken test... 04:53:32 INFO - TEST-INFO | started process 28384 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp41Ra5j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:53:44 INFO - PROCESS | 28384 | RSS: Main: 144576512 04:53:44 INFO - PROCESS | 28384 | 04:53:47 INFO - PROCESS | 28384 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57334/tests/kraken/driver.html?testName=audio-beat-detection) 04:53:48 INFO - PROCESS | 28384 | RSS: Main: 151470080 04:53:48 INFO - PROCESS | 28384 | 04:53:50 INFO - PROCESS | 28384 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57334/tests/kraken/driver.html?testName=audio-dft) 04:53:51 INFO - PROCESS | 28384 | RSS: Main: 150786048 04:53:51 INFO - PROCESS | 28384 | 04:53:54 INFO - PROCESS | 28384 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57334/tests/kraken/driver.html?testName=audio-fft) 04:53:54 INFO - PROCESS | 28384 | RSS: Main: 150589440 04:53:54 INFO - PROCESS | 28384 | 04:53:56 INFO - PROCESS | 28384 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57334/tests/kraken/driver.html?testName=audio-oscillator) 04:53:57 INFO - PROCESS | 28384 | RSS: Main: 150405120 04:53:57 INFO - PROCESS | 28384 | 04:53:59 INFO - PROCESS | 28384 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57334/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:54:00 INFO - PROCESS | 28384 | RSS: Main: 149663744 04:54:00 INFO - PROCESS | 28384 | 04:54:03 INFO - PROCESS | 28384 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57334/tests/kraken/driver.html?testName=imaging-darkroom) 04:54:03 INFO - PROCESS | 28384 | RSS: Main: 153042944 04:54:03 INFO - PROCESS | 28384 | 04:54:07 INFO - PROCESS | 28384 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57334/tests/kraken/driver.html?testName=imaging-desaturate) 04:54:07 INFO - PROCESS | 28384 | RSS: Main: 153817088 04:54:07 INFO - PROCESS | 28384 | 04:54:10 INFO - PROCESS | 28384 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57334/tests/kraken/driver.html?testName=json-parse-financial) 04:54:11 INFO - PROCESS | 28384 | RSS: Main: 153206784 04:54:11 INFO - PROCESS | 28384 | 04:54:12 INFO - PROCESS | 28384 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57334/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:54:13 INFO - PROCESS | 28384 | RSS: Main: 152522752 04:54:13 INFO - PROCESS | 28384 | 04:54:15 INFO - PROCESS | 28384 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57334/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:54:15 INFO - PROCESS | 28384 | RSS: Main: 152305664 04:54:15 INFO - PROCESS | 28384 | 04:54:17 INFO - PROCESS | 28384 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57334/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:54:18 INFO - PROCESS | 28384 | RSS: Main: 153006080 04:54:18 INFO - PROCESS | 28384 | 04:54:20 INFO - PROCESS | 28384 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:54:21 INFO - PROCESS | 28384 | RSS: Main: 152707072 04:54:21 INFO - PROCESS | 28384 | 04:54:24 INFO - PROCESS | 28384 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:54:25 INFO - PROCESS | 28384 | RSS: Main: 153829376 04:54:25 INFO - PROCESS | 28384 | 04:54:26 INFO - PROCESS | 28384 | Cycle 1(1): loaded http://localhost:57334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57334/tests/kraken/driver.html?testName=ai-astar) 04:54:26 INFO - PROCESS | 28384 | RSS: Main: 155336704 04:54:26 INFO - PROCESS | 28384 | 04:54:26 INFO - PROCESS | 28384 | __start_tp_report 04:54:26 INFO - PROCESS | 28384 | _x_x_mozilla_page_load 04:54:26 INFO - PROCESS | 28384 | _x_x_mozilla_page_load_details 04:54:26 INFO - PROCESS | 28384 | |i|pagename|runs| 04:54:26 INFO - PROCESS | 28384 | |0;ai-astar;103;114;113;112;112;111;111;112;111;112 04:54:26 INFO - PROCESS | 28384 | |1;audio-beat-detection;139;120;120;154;117;119;118;120;134;120 04:54:26 INFO - PROCESS | 28384 | |2;audio-dft;164;164;161;160;161;163;163;161;162;160 04:54:26 INFO - PROCESS | 28384 | |3;audio-fft;75;75;76;111;75;75;75;75;88;75 04:54:26 INFO - PROCESS | 28384 | |4;audio-oscillator;84;85;105;84;83;83;91;83;83;96 04:54:26 INFO - PROCESS | 28384 | |5;imaging-gaussian-blur;120;118;117;118;118;117;118;120;118;120 04:54:26 INFO - PROCESS | 28384 | |6;imaging-darkroom;148;147;148;148;148;147;148;148;147;146 04:54:26 INFO - PROCESS | 28384 | |7;imaging-desaturate;97;96;95;96;96;97;96;95;97;96 04:54:26 INFO - PROCESS | 28384 | |8;json-parse-financial;56;56;57;56;61;57;57;56;57;59 04:54:26 INFO - PROCESS | 28384 | |9;json-stringify-tinderbox;64;64;64;64;64;63;64;63;63;64 04:54:26 INFO - PROCESS | 28384 | |10;stanford-crypto-aes;74;76;81;76;82;76;75;85;76;76 04:54:26 INFO - PROCESS | 28384 | |11;stanford-crypto-ccm;125;130;121;119;131;129;121;129;160;131 04:54:26 INFO - PROCESS | 28384 | |12;stanford-crypto-pbkdf2;160;160;160;163;155;156;167;156;159;161 04:54:26 INFO - PROCESS | 28384 | |13;stanford-crypto-sha256-iterative;62;61;61;65;61;70;60;61;61;62 04:54:26 INFO - PROCESS | 28384 | __end_tp_report 04:54:26 INFO - PROCESS | 28384 | __start_cc_report 04:54:26 INFO - PROCESS | 28384 | _x_x_mozilla_cycle_collect,729 04:54:26 INFO - PROCESS | 28384 | __end_cc_report 04:54:26 INFO - PROCESS | 28384 | __startTimestamp1486644866957__endTimestamp 04:54:26 INFO - PROCESS | 28384 | 04:54:26 INFO - PROCESS | 28384 | ------- Summary: start ------- 04:54:26 INFO - PROCESS | 28384 | Number of tests: 14 04:54:26 INFO - PROCESS | 28384 | 04:54:26 INFO - PROCESS | 28384 | [#0] ai-astar Cycles:10 Average:111.10 Median:112.00 stddev:3.00 (2.7%) stddev-sans-first:1.00 04:54:26 INFO - PROCESS | 28384 | Values: 103.0 114.0 113.0 112.0 112.0 111.0 111.0 112.0 111.0 112.0 04:54:26 INFO - PROCESS | 28384 | 04:54:26 INFO - PROCESS | 28384 | [#1] audio-beat-detection Cycles:10 Average:126.10 Median:120.00 stddev:12.27 (10.2%) stddev-sans-first:12.09 04:54:26 INFO - PROCESS | 28384 | Values: 139.0 120.0 120.0 154.0 117.0 119.0 118.0 120.0 134.0 120.0 04:54:26 INFO - PROCESS | 28384 | 04:54:26 INFO - PROCESS | 28384 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.50 stddev:1.52 (0.9%) stddev-sans-first:1.41 04:54:26 INFO - PROCESS | 28384 | Values: 164.0 164.0 161.0 160.0 161.0 163.0 163.0 161.0 162.0 160.0 04:54:26 INFO - PROCESS | 28384 | 04:54:26 INFO - PROCESS | 28384 | [#3] audio-fft Cycles:10 Average:80.00 Median:75.00 stddev:11.62 (15.5%) stddev-sans-first:12.19 04:54:26 INFO - PROCESS | 28384 | Values: 75.0 75.0 76.0 111.0 75.0 75.0 75.0 75.0 88.0 75.0 04:54:26 INFO - PROCESS | 28384 | 04:54:26 INFO - PROCESS | 28384 | [#4] audio-oscillator Cycles:10 Average:87.70 Median:84.00 stddev:7.47 (8.9%) stddev-sans-first:7.80 04:54:26 INFO - PROCESS | 28384 | Values: 84.0 85.0 105.0 84.0 83.0 83.0 91.0 83.0 83.0 96.0 04:54:26 INFO - PROCESS | 28384 | 04:54:26 INFO - PROCESS | 28384 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.00 stddev:1.17 (1.0%) stddev-sans-first:1.09 04:54:26 INFO - PROCESS | 28384 | Values: 120.0 118.0 117.0 118.0 118.0 117.0 118.0 120.0 118.0 120.0 04:54:26 INFO - PROCESS | 28384 | 04:54:26 INFO - PROCESS | 28384 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.71 (0.5%) stddev-sans-first:0.73 04:54:26 INFO - PROCESS | 28384 | Values: 148.0 147.0 148.0 148.0 148.0 147.0 148.0 148.0 147.0 146.0 04:54:26 INFO - PROCESS | 28384 | 04:54:26 INFO - PROCESS | 28384 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 04:54:26 INFO - PROCESS | 28384 | Values: 97.0 96.0 95.0 96.0 96.0 97.0 96.0 95.0 97.0 96.0 04:54:26 INFO - PROCESS | 28384 | 04:54:26 INFO - PROCESS | 28384 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:57.00 stddev:1.62 (2.8%) stddev-sans-first:1.66 04:54:26 INFO - PROCESS | 28384 | Values: 56.0 56.0 57.0 56.0 61.0 57.0 57.0 56.0 57.0 59.0 04:54:26 INFO - PROCESS | 28384 | 04:54:26 INFO - PROCESS | 28384 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 04:54:26 INFO - PROCESS | 28384 | Values: 64.0 64.0 64.0 64.0 64.0 63.0 64.0 63.0 63.0 64.0 04:54:26 INFO - PROCESS | 28384 | 04:54:26 INFO - PROCESS | 28384 | [#10] stanford-crypto-aes Cycles:10 Average:77.70 Median:76.00 stddev:3.62 (4.8%) stddev-sans-first:3.59 04:54:26 INFO - PROCESS | 28384 | Values: 74.0 76.0 81.0 76.0 82.0 76.0 75.0 85.0 76.0 76.0 04:54:26 INFO - PROCESS | 28384 | 04:54:26 INFO - PROCESS | 28384 | [#11] stanford-crypto-ccm Cycles:10 Average:129.60 Median:129.50 stddev:11.60 (9.0%) stddev-sans-first:12.18 04:54:26 INFO - PROCESS | 28384 | Values: 125.0 130.0 121.0 119.0 131.0 129.0 121.0 129.0 160.0 131.0 04:54:26 INFO - PROCESS | 28384 | 04:54:26 INFO - PROCESS | 28384 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.70 Median:160.00 stddev:3.59 (2.2%) stddev-sans-first:3.81 04:54:26 INFO - PROCESS | 28384 | Values: 160.0 160.0 160.0 163.0 155.0 156.0 167.0 156.0 159.0 161.0 04:54:26 INFO - PROCESS | 28384 | 04:54:26 INFO - PROCESS | 28384 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:61.50 stddev:2.99 (4.9%) stddev-sans-first:3.17 04:54:26 INFO - PROCESS | 28384 | Values: 62.0 61.0 61.0 65.0 61.0 70.0 60.0 61.0 61.0 62.0 04:54:26 INFO - PROCESS | 28384 | -------- Summary: end -------- 04:54:26 INFO - PROCESS | 28384 | 04:54:27 INFO - TEST-INFO | 28384: exit 0 04:54:27 INFO - TEST-OK | kraken | took 60383ms 04:54:27 INFO - SUITE-END | took 1171s 04:54:28 INFO - Completed test suite (00:19:31) 04:54:28 INFO - javascript benchmark 04:54:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7543.536340571711, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3236.8867089651867, 3260.168656992468, 3280.0651814232947, 3283.1463819406945, 3285.5728755261825, 5338.89322213556, 5393.164059570763, 5428.104362780142, 5433.347998240207, 5472.945270547293, 5431.266778984836, 5482.259894914186, 5483.7806487740445, 5496.0, 5506.559475241981, 4906.803727850882, 4922.581580565657, 4947.505249475042, 4964.801407943678, 4987.102321582114, 4932.728699921503, 4985.052839960414, 5002.074616195997, 5002.624803139761, 5019.874503137433, 4823.686460380064, 4852.223644216926, 4964.826231081913, 4994.051130285234, 5036.949630503703, 4838.854834354993, 4857.319975203474, 4933.777979990909, 4956.653034287601, 4958.851234462972, 4927.679700819471, 4931.482194369575, 4941.604671626297, 4948.604111671094, 4963.6277279204205, 5379.300690910196, 5381.19282107687, 5394.541463975567, 5471.835844924619, 5471.972640136813, 5689.971550142222, 5716.028275193227, 5738.024535828919, 5775.711214439261, 5797.0, 5893.44012318829, 5914.2902851657645, 5922.940770592282, 5926.703664816742, 5931.377205393414, 5527.695976721278, 5534.972325138348, 5535.142052981794, 5543.8891222175735, 5552.805651802168, 5767.85580360486, 5817.214676018768, 5839.883202335929, 5972.25346831646, 6006.069059295816, 5647.915281270784, 5668.26312579362, 5709.600327977002, 5749.540036797046, 5777.30672319316, 5780.88438231233, 5783.0, 5836.445537673914, 5842.707864606838, 5851.736671849777, 5529.889402211933, 5823.417658234227, 5826.126081087786, 5829.0, 5837.532997360201, 5637.26715526987, 5706.087026075808, 5725.169850371756, 5745.195672605755, 5816.243888294579, 4491.752953587584, 4504.09918016398, 4505.189065968091, 4519.0, 4538.11506756186, 3961.207758448322, 3985.740926839746, 3988.3818008208773, 4014.3175660137263, 4021.7586944783407, 5515.917261241085, 5535.58483113768, 5550.8057217997175, 5564.137558678412, 5574.247476590689, 5851.297844258716, 5851.824445266649, 5856.355800861902, 5890.764369425261, 5916.585838991229, 5479.917801232985, 5521.475459831309, 5530.668159910338, 5613.943860561424, 5681.261436013292, 4873.829415970424, 4967.0, 4982.103221420107, 4982.900341993212, 4986.700797952134, 6020.367861374581, 6054.697265136726, 6059.969700151471, 6082.847928801727, 6085.66528840918, 5618.410066943075, 5648.068068768607, 5806.65160090396, 5838.854028649148, 5858.150568167677, 5909.261342332208, 5917.644941303535, 5920.200772895776, 5924.111383292368, 5932.0508718604815, 5609.4390560943575, 5617.32592088952, 5684.204211410323, 5691.0, 5772.163036359789, 5823.534117270693, 5828.679422631626, 5829.09649004405, 5836.591438599427, 5844.064949608042, 5557.5831812613405, 5644.955683198621, 5661.915071273852, 5694.117411801178, 5710.5717071219, 5525.392206857323, 5560.165975103767, 5560.443955604407, 5597.188407680945, 5673.461021202979, 5637.041702910597, 5646.153077038477, 5657.26455560791, 5670.149477578396, 5674.4892959633835, 5639.3232812062815, 5676.120201368794, 5683.829485115453, 5713.942860571341, 5715.142728590745, 5483.670979741229, 5544.140658197985, 5545.445455454423, 5575.581831362583, 5584.46947539983], "value": 5363.085134586325, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.2676429837759, 601.7171929193279, 614.0880792023843, 695.7112798188751, 718.2637796258831, 43804.342934856, 44858.775706121465, 47808.760956195256, 47899.281510777364, 48168.75915620426, 48616.75691621537, 49765.502344976536, 50070.49929500713, 50224.748876255566, 50236.49763502364, 9144.95427522863, 10675.19936004799, 11002.614908478205, 11057.889421105767, 11421.25761825483, 10866.891331086706, 10916.399598022106, 10978.560857565688, 11030.06244469221, 11050.0, 11075.944620276927, 11099.278546894466, 11117.833232501518, 11125.443727813617, 11176.497057632427, 11047.392393418359, 11049.447527623586, 11082.833757493645, 11089.722756931102, 11091.445427728662, 10926.726831829188, 11012.614558490415, 11032.338059716443, 11060.502277397536, 11076.39079850608, 42523.78738106321, 42596.787016065035, 42930.14139717188, 43131.13737725259, 43172.78413607912, 4443.866683999485, 4458.1306645204195, 4495.820167193308, 4607.677462577621, 4614.72311661298, 31618.209544761336, 31661.36677266465, 32141.839290803397, 32540.0, 33066.0, 4238.295924409253, 4501.594856462902, 4530.977345113286, 4552.52198519154, 4568.0407114506, 207739.0, 210120.0, 210516.0, 210943.0, 211645.0, 62911.0, 62992.370076299565, 63260.683696581225, 63293.0, 63377.0, 65466.0, 65527.67236163789, 65605.0, 65817.0, 65839.67080164568, 18523.44429667112, 18706.625867482573, 19029.333973310866, 19384.80615193858, 19459.31892383788, 14349.928250358682, 14388.496402625859, 14468.0, 14490.710185796224, 14533.563993080224, 19855.205791768458, 20350.28773992903, 20382.388528344174, 20426.38720838377, 20516.38450846477, 7363.447741419415, 7649.655765490566, 7683.5774032427635, 7733.265339792711, 7917.802054948557, 988.1304452082265, 989.7624570103268, 1013.9695809125737, 1019.3679918450608, 1039.4750650921237, 33402.832985835405, 33516.49725254123, 33568.0, 33769.0, 33935.32129357399, 1101.779644071189, 1137.0960086731068, 1145.4593571646124, 1164.831099490586, 1180.2682336951145, 17450.825491745174, 17457.301707931794, 17532.29870805179, 17640.735388969177, 17739.911300443415, 538048.0, 556519.0, 560593.0, 565191.0, 845857.0, 62346.0, 62469.68765156236, 62543.6872815633, 62842.37157628457, 63318.68340658267, 1526.5801904476136, 1553.3786485405928, 1556.820965588949, 1562.5859147325968, 1570.3718512594826, 31312.0, 31396.68603314029, 31427.84286078555, 31713.841430792698, 32407.027789166365, 53586.73206634098, 54472.182917257065, 54611.45388546223, 54709.452905472026, 54738.72630636821, 493328.0, 494882.0, 496300.0, 497172.0, 498727.0, 28834.0, 28979.710202897702, 29690.703092968793, 29987.70012299849, 31904.840475798403, 48076.5192348072, 48087.51912480831, 48378.274325885846, 48928.75535622299, 49009.0, 41701.1659766809, 42593.0, 42608.1478370437, 43020.0, 43182.0, 39569.406458903715, 39843.0, 41019.1796164081, 41268.79365603153, 41770.16459670729, 38118.0, 39441.211175776894, 40053.59946400499, 41167.588324117576, 41337.58662413337, 33954.0, 35282.11794705153, 35363.0, 35644.46533302055, 35895.82052089723, 27241.727582723917, 27539.862300688368, 27664.58503122495, 27705.44589108247, 27772.166834994983], "value": 21436.126003448106, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [418.31605325293134, 429.4974879391112, 432.5628613886152, 434.6349066783901, 438.56801050964805, 19795.208191672333, 21742.565148697016, 21862.0, 22815.31554053381, 23047.423814404647, 22755.203567875127, 22920.197793077245, 23067.0, 23198.420039499022, 23357.299281021555, 6096.939030609704, 6150.477209437203, 6287.497000239992, 6335.239771227459, 6337.271213810402, 6064.0, 6193.6283822970545, 6194.318624951252, 6194.349593292707, 6198.4731297839735, 5934.258217722785, 6115.816525504242, 6135.417135372155, 6168.96915515424, 6170.784022559212, 6046.12331211974, 6121.571489995702, 6170.0, 6173.351798061184, 6181.5672902896595, 5360.973195133999, 5535.335759708821, 5543.805966791183, 5568.49883510486, 5590.692511911843, 25693.871530642227, 25874.0, 26001.089961851245, 26079.73920260811, 26135.73864261352, 3225.3388055448577, 3357.4795906634513, 3372.898813035613, 3401.0817079388426, 3425.0409885232175, 15796.605084872856, 15906.52280431589, 16080.276387562588, 16116.194190290438, 16502.2573984171, 1966.5575245569776, 1991.3229501969256, 1997.4007797660788, 1999.2003198720483, 2010.2361102780997, 89992.55003725005, 91533.0, 91568.08431915662, 92446.53776731073, 93832.53083734537, 11875.40622968848, 12308.815367769312, 12470.0, 12826.486940522274, 12828.166169198972, 17063.573410664834, 17105.657886842193, 17148.82851171497, 17201.1399430028, 17238.569035774206, 9394.62421503146, 9487.146156845916, 9616.182624476858, 9693.515324233902, 9758.268129890286, 9381.343305968654, 9405.247580193569, 9418.152366287068, 9449.43303401798, 9713.320067595341, 7750.0, 7825.843483130306, 7861.292483676382, 7917.564533950573, 7956.403269754792, 2041.4386043838063, 2096.371088673392, 2120.480482281851, 2162.924297649606, 2201.218567408579, 1160.3502038858267, 1179.4692388425242, 1188.518649946773, 1190.6487586162102, 1196.5333519927235, 19313.324033658755, 20023.39929802079, 20848.687269690967, 20894.164233430492, 20955.057022434026, 1172.202902026613, 1176.1766763265748, 1181.3797756177903, 1186.2170967161633, 1208.3173007250875, 11352.0, 11870.584529541424, 11967.64097077089, 12021.398930053638, 12032.217905836093, 618286.0, 626345.0, 663286.0, 669425.0, 709271.0, 85248.0, 85955.0, 86471.56764216139, 87772.5611371939, 88841.0, 1105.3036586950332, 1112.2158877990996, 1114.4205013393153, 1117.5697356517799, 1129.271619805221, 17787.73318400251, 18115.54711132232, 18162.364317248834, 18172.45482635523, 18583.53541161482, 42332.36501452419, 42531.57468425276, 42660.360094597985, 43042.35436468393, 43421.13157736765, 56144.438555615554, 56486.0, 56924.43075569357, 57490.13764793615, 57662.13506797485, 8369.49783013021, 8608.98685460084, 8836.160564746338, 8867.0689577596, 9058.456492610465, 8419.284360829153, 13229.544750077292, 13643.727125457634, 13779.104358216684, 14637.840746590733, 11919.821202681793, 12657.87342126567, 12671.303078330411, 12739.681507962005, 12900.29048402347, 11736.178467507534, 12112.939435302767, 12587.433565489759, 12673.465306938464, 12813.679658008625, 11808.763824723286, 12755.107142499935, 12859.871401285867, 12914.935425322814, 13042.673933151367, 9641.710748677551, 9768.658096966572, 9794.461304628314, 9795.9020409795, 9970.800583988135, 10032.64885728996, 12662.556810511587, 12742.362881855684, 12785.16896401731, 13048.151870128411], "value": 10366.19045972161, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1458.5405597236877, 1472.9631759206018, 1475.7048590281947, 1480.2450750117441, 1483.110133919648, 7557.24427557244, 7797.337226335754, 8011.759647210586, 8489.278411335044, 8491.0, 8096.068952070514, 8270.297024752888, 8345.332373410129, 8517.53153576553, 8524.232819046285, 2364.125273648748, 2405.747396523366, 2412.1075202175134, 2417.456072383717, 2423.430493833948, 2314.6296592545195, 2330.650402439631, 2335.1126571902737, 2341.6370462578243, 2343.273585188597, 2355.0697474497647, 2370.0401337458356, 2371.3597328721235, 2378.7621237876247, 2400.1719406804714, 2285.3486756274465, 2292.106078629336, 2306.8961896714686, 2316.8030717388956, 2318.976810231893, 2285.097386532327, 2335.427820184049, 2337.4740683346113, 2348.38941875112, 2375.10933399975, 8398.622062007224, 8429.789255268606, 8433.367497437717, 8474.364422668325, 8478.576071196416, 5015.348004759395, 5241.056609810233, 5316.202569614588, 5332.066888294533, 5345.812896548641, 3190.5692731481186, 3278.1804548862783, 3352.513885486615, 3380.408428525023, 3393.100828280483, 1379.0622376783783, 1379.5999160243518, 1406.0298394108136, 1415.2216281045385, 1448.6016345504966, 10474.26680132391, 10541.0, 10546.0, 10585.206109541816, 10621.41582212978, 4535.115652447807, 4566.474855391606, 4636.35091087248, 4712.481627021093, 4739.526047395302, 9752.024797520333, 9816.460094694861, 9826.213902887752, 9857.11285984265, 9860.654877079267, 5415.891682166334, 5416.241726158341, 5417.133258678593, 5417.945820541744, 5422.349318081855, 4348.826046958086, 4756.571908528249, 4792.592629626521, 4863.2461968394955, 4904.509549045067, 4010.498687664042, 4068.3694027425795, 4075.1034772350035, 4146.813393397304, 4147.19129769692, 1341.0076543357845, 1342.812006319116, 1353.6954185308227, 1357.6673714939902, 1360.5646193218074, 950.9762255943657, 982.9311948163703, 989.1888651306004, 998.1715176403568, 1019.4545917934018, 5480.369757477862, 5721.914171287434, 5758.74085666146, 5781.19063331134, 5807.419258074159, 635.3487675133026, 635.5519358851998, 641.4804008752925, 646.1954866191621, 657.552864052449, 3794.829232684536, 3842.9231415371537, 3851.7111216658864, 3860.189360234382, 3875.2443273561385, 9828.655997040069, 10181.389116653025, 10191.133753631024, 10210.13213876814, 10216.029477199654, 10053.949730251303, 10113.443760593238, 10117.747056323651, 10126.39241645489, 10127.493625318704, 7406.925930740624, 7969.481983671043, 8023.679052837938, 8030.598470076473, 8052.758417247492, 5104.923426148685, 5116.053530096944, 5151.0470562945975, 5176.1200595898035, 5247.055530004636, 9102.135297147026, 9156.862647060432, 9157.908420915972, 9196.862047069433, 9213.12475314844, 9219.86170207434, 9348.25213982866, 9365.203957663674, 9435.198008169107, 9473.100055494717, 7576.052993375828, 7706.922930770845, 7807.336376408069, 7955.363570914429, 8025.398095142771, 8035.236652518001, 8319.168083191633, 8319.792005199677, 8334.791630209293, 8347.040090389683, 7183.353498185188, 7219.0976127984, 7259.6007219603425, 7270.0886644665625, 7659.0, 7100.751473698396, 7259.854802903807, 7387.741429049957, 7426.405887529093, 7457.515261508202, 6405.615663060231, 6499.447546958561, 6762.323767623198, 6805.421539169028, 6839.281875403011, 4561.817527298871, 4567.497575266651, 4761.0, 4814.446338670958, 4951.9257211142585, 4818.759062046814, 4829.106615276185, 4830.734309613005, 4882.023595281029, 5034.798608055783], "value": 4474.903995464761, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [397.77923252594815, 398.4202984657323, 409.4533797380497, 412.57916924736753, 415.46405137372807, 5322.680639161644, 5401.918971215435, 5440.918386224205, 5478.096114141167, 5515.172724091383, 5154.098032844256, 5274.92087618686, 5277.076511610472, 5350.652207606503, 5382.865428364293, 4287.121140166266, 4293.355996600504, 4312.792418122931, 4320.719153255029, 4348.652107831382, 4176.290030694774, 4230.16578892143, 4230.534641189467, 4251.278232315917, 4302.26861433557, 4193.0, 4196.832126714943, 4215.894602634928, 4223.788810559459, 4241.257779888522, 4248.447701798762, 4255.340422234543, 4259.0, 4266.616004559604, 4285.957140428587, 3702.3520883845217, 3713.4801127842125, 3735.383661695817, 3772.5661548921953, 3806.162644218295, 5285.656432331886, 5314.811113332009, 5318.175682769177, 5323.459899167088, 5354.0, 4929.507049295078, 4940.827071052496, 4946.233333833262, 4955.5044495550155, 4976.850694479172, 5700.857478563028, 5711.742971566289, 5715.771369145229, 5741.712914354265, 5770.134479828017, 4193.832246710128, 4198.467559340818, 4201.957980420218, 4211.0, 4216.3464662976985, 5778.451047150514, 5890.4698577128265, 5934.703264836741, 5947.524198064188, 6002.819915402545, 4257.765822879709, 4311.935320970188, 4312.396264522969, 4318.589733975267, 4331.7834108294455, 4381.561843815657, 4399.340098985178, 4401.691881568324, 4404.757738324359, 4426.667999899956, 4852.320675105488, 4932.284818701268, 4998.300237966688, 5013.799448022039, 5044.924326135111, 5778.88442231153, 5780.0, 5788.131780232999, 5791.420857914175, 5831.183634291203, 1456.1627064437992, 1461.729580027677, 1465.7288401645517, 1469.5297504798361, 1474.2039298778539, 986.240594742059, 996.3075662414552, 1018.2973748113777, 1028.7068185567077, 1032.865727455441, 5524.364698059694, 5548.9722551386985, 5549.833504994856, 5552.556335352838, 5562.692767199705, 5796.913046304308, 5798.057650686983, 5804.0, 5806.82579522615, 5872.588918775645, 5273.947260527422, 5472.699001554953, 5493.917591236134, 5526.640768350125, 5562.916556251659, 3020.365723198153, 3020.622422197225, 3035.195673146618, 3042.710942460463, 3046.7562594992346, 5733.312002559636, 5903.144044113666, 5923.970380148072, 5977.6114552553945, 6047.758089676364, 5952.345242023374, 6006.0, 6033.978617163211, 6044.909326360108, 6084.482818960438, 6069.180660610849, 6110.236220472441, 6120.296165940974, 6188.2883468400805, 6200.875982480326, 5613.354464236665, 5915.171875937458, 5919.556033297606, 5936.406359364029, 5941.287045554561, 5850.853728656818, 5918.704064796657, 5922.2597175353085, 5948.226730525004, 5965.940340596712, 5860.208871802422, 6076.878462430638, 6097.817065488042, 6119.3268740437625, 6244.188255526752, 4249.0, 4292.283086765319, 4310.504292006334, 4311.461067366579, 4311.935320970125, 5758.222639943554, 5900.813560677187, 5903.527717782653, 5935.643861368331, 5936.931352356444, 5743.10981797822, 5746.454086861741, 5756.7409466574945, 5782.884342313214, 5786.450287222707, 5755.280589926259, 5768.365479797135, 5775.33583637887, 5802.738876750472, 5823.563232757476, 5461.399246082849, 5695.914561281501, 5729.140628905531, 5754.884902302014, 5755.194272801895, 5777.104548794943, 5801.477866991991, 5809.448102430262, 5838.737256823369, 5865.44565690101, 5530.349969020588, 5714.485696287354, 5719.456651618089, 5723.570732195185, 5745.368009519033], "value": 4419.485498881794, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [828.0708040348551, 846.8518009348362, 858.2104463893218, 939.126612250607, 958.3818437108064, 16169.272382742776, 17281.82718172818, 17514.649707005854, 18131.365402210926, 18335.449936501893, 15828.920855395736, 15929.92035039826, 16256.268467918942, 16712.41506547268, 16931.83068169318, 841.8442588121187, 857.2841677199546, 858.6822875536029, 859.2095272349453, 860.6471346747835, 834.3408707121367, 857.8884744983144, 858.935579831512, 860.2859626509982, 862.1637012098286, 880.2210044110976, 895.7671005538574, 896.9372143949926, 901.4636291406603, 904.9502277374742, 894.9463032218088, 900.7162743735735, 902.165496915354, 902.2511315608095, 903.1735961595166, 657.4083325007483, 657.4444594317794, 658.993410065898, 659.6273105695267, 661.2362721057139, 17361.7395739064, 17582.29670813166, 17807.0, 17843.10784460772, 17888.91055544727, 16484.670306593922, 16634.58413539659, 16704.74942875858, 16766.41317553892, 17104.57238569033, 13536.59390218295, 13689.452421903112, 13726.313684315744, 13761.655958601015, 14003.299835008209, 4006.3389540725743, 4051.108756073659, 4063.553009168989, 4064.0, 4070.063885306396, 85984.57007714984, 86413.0, 87172.0, 87918.12081879227, 89588.0, 12803.0, 12993.876893329149, 13042.347882605833, 13068.54260100892, 13180.681931806934, 24247.600415117195, 24519.0, 24582.754172458404, 24661.136860210165, 24738.628920566207, 8875.955620221857, 8903.955480222687, 9016.819663606691, 9132.589033493508, 9164.358494905426, 4985.426675932242, 5038.0, 5050.772715227824, 5059.443461219263, 5145.845624631267, 3669.7798132112157, 3762.6613604775703, 3765.811709414573, 3767.472553842464, 3768.1333293342686, 647.9546431749826, 650.2749434380631, 654.0810161722787, 660.8975608780647, 673.0678010954765, 799.2407213147533, 814.4950130918868, 825.2468062552407, 840.306746933782, 842.1999100854091, 10960.671179864617, 11189.272697274651, 11235.0, 11461.842171022907, 11809.23239989398, 670.7987603718963, 672.0658284983876, 686.5811854768588, 688.7589343729654, 696.6377483708544, 5145.742712864342, 5416.0, 5436.864078398072, 5525.585581081355, 5535.833924982257, 86204.56897715472, 86590.0, 86897.56551217203, 86999.56500217458, 87601.12398876058, 75622.0, 75826.62086689532, 77082.0, 77567.61216193996, 78137.21862781413, 66655.66672166705, 68191.0, 69431.65284173547, 69611.3038869615, 69702.0, 10276.743081423025, 10329.0, 10426.0, 10629.734256643645, 10641.361518308617, 42013.57986420097, 43712.56287437085, 44223.557764421945, 44668.55331446644, 45225.77387113175, 55030.0, 55412.72293638506, 57539.71230143822, 57669.711651443155, 58390.7080464595, 13662.658433538843, 14159.150450972975, 14179.14925104497, 14212.0, 14372.928135359256, 14996.250187490363, 14998.0, 15019.399224030916, 15092.54722358331, 15408.383664653289, 13414.798778018532, 13828.08858386769, 14040.157590544191, 14098.577042688736, 14491.0, 14255.287235637968, 14291.714165716836, 14468.710625787637, 14684.706305874037, 15007.399704011717, 13640.727185456433, 13780.724385512434, 13960.79058814139, 14083.014189006672, 14290.714185716019, 10399.1160751337, 10530.684079477627, 10598.04617584421, 10702.250842441266, 10905.400202988912, 9767.658131965347, 10464.476776161313, 10482.423466709404, 10508.684739457829, 10555.472226388496], "value": 7817.461392169506, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1479.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 113.0, 112.0, 112.0, 111.0, 111.0, 112.0, 111.0, 112.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 120.0, 120.0, 154.0, 117.0, 119.0, 118.0, 120.0, 134.0, 120.0], "value": 126.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 161.0, 160.0, 161.0, 163.0, 163.0, 161.0, 162.0, 160.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 111.0, 75.0, 75.0, 75.0, 75.0, 88.0, 75.0], "value": 80.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 105.0, 84.0, 83.0, 83.0, 91.0, 83.0, 83.0, 96.0], "value": 87.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 117.0, 118.0, 118.0, 117.0, 118.0, 120.0, 118.0, 120.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 148.0, 147.0, 148.0, 148.0, 147.0, 146.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 95.0, 96.0, 96.0, 97.0, 96.0, 95.0, 97.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 57.0, 56.0, 61.0, 57.0, 57.0, 56.0, 57.0, 59.0], "value": 57.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 63.0, 63.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 81.0, 76.0, 82.0, 76.0, 75.0, 85.0, 76.0, 76.0], "value": 77.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 130.0, 121.0, 119.0, 131.0, 129.0, 121.0, 129.0, 160.0, 131.0], "value": 129.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 163.0, 155.0, 156.0, 167.0, 156.0, 159.0, 161.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 65.0, 61.0, 70.0, 60.0, 61.0, 61.0, 62.0], "value": 62.4, "unit": "score"}]}]} 04:54:28 INFO - Return code: 0 04:54:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:54:28 ERROR - # TBPL SUCCESS # 04:54:28 INFO - Running post-action listener: _resource_record_post_action 04:54:28 INFO - [mozharness: 2017-02-09 12:54:28.267736Z] Finished run-tests step (success) 04:54:28 INFO - Running post-run listener: _resource_record_post_run 04:54:28 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 40960; Write bytes: 367157248; Read time: 136; Write time: 226012 04:54:28 INFO - TinderboxPrint: CPU usage
13.3% 04:54:28 INFO - TinderboxPrint: I/O read bytes / time
40,960 / 136 04:54:28 INFO - TinderboxPrint: I/O write bytes / time
367,157,248 / 226,012 04:54:28 INFO - TinderboxPrint: CPU idle
8,219.7 (86.7%) 04:54:28 INFO - TinderboxPrint: CPU user
1,204.8 (12.7%) 04:54:28 INFO - TinderboxPrint: Swap in / out
0 / 0 04:54:28 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109842432; Read time: 0; Write time: 97876 04:54:28 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 40960; Write bytes: 257314816; Read time: 136; Write time: 128136 04:54:28 INFO - Running post-run listener: _upload_blobber_files 04:54:28 INFO - Blob upload gear active. 04:54:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:54:28 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 04:54:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:54:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:54:29 INFO - (blobuploader) - INFO - Open directory for files ... 04:54:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:54:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:54:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:30 INFO - (blobuploader) - INFO - Done attempting. 04:54:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:54:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:54:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:33 INFO - (blobuploader) - INFO - Done attempting. 04:54:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:54:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:54:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:34 INFO - (blobuploader) - INFO - Done attempting. 04:54:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:54:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:54:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:35 INFO - (blobuploader) - INFO - Done attempting. 04:54:35 INFO - (blobuploader) - INFO - Iteration through files over. 04:54:35 INFO - Return code: 0 04:54:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:54:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:54:35 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/336df2887176168452823b638811016b6ff904d50013467b9a9be30ac22906b700e62c106e818c72c7bee78c435420f37517cba28f8dd86e6f16ebe699bc159f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/1aa92fbe5dc10267828e73c2d7c4ceb362a79103f8fa82a8d7253a4d7164ed60adcaa7c7dd2fd651597012f97ef4df5ad9c87605da9757683c67616aeb224119", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b703ac3d6a095ea3a536b9ad23edc5ce8c72227924f9c18ad3925b6ffd4724321bc484e351806e775109d688780c61a560abf6bb4722b5d189e6da61c9146c4b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/775cc5e18d3bd1bf890431b7d5ba8f5575b0fd46c76a4bfcb9c9324456a7cc4daba6ca35bb3ed669bc5bc49971cd470ad6f9463542dd50c65209ff4f4a328d18"} 04:54:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:54:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:54:35 INFO - Contents: 04:54:35 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/336df2887176168452823b638811016b6ff904d50013467b9a9be30ac22906b700e62c106e818c72c7bee78c435420f37517cba28f8dd86e6f16ebe699bc159f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/1aa92fbe5dc10267828e73c2d7c4ceb362a79103f8fa82a8d7253a4d7164ed60adcaa7c7dd2fd651597012f97ef4df5ad9c87605da9757683c67616aeb224119", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b703ac3d6a095ea3a536b9ad23edc5ce8c72227924f9c18ad3925b6ffd4724321bc484e351806e775109d688780c61a560abf6bb4722b5d189e6da61c9146c4b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/775cc5e18d3bd1bf890431b7d5ba8f5575b0fd46c76a4bfcb9c9324456a7cc4daba6ca35bb3ed669bc5bc49971cd470ad6f9463542dd50c65209ff4f4a328d18"} 04:54:35 INFO - Running post-run listener: copy_logs_to_upload_dir 04:54:35 INFO - Copying logs to upload dir... 04:54:35 INFO - mkdir: /builds/slave/test/build/upload/logs 04:54:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.494376 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-02-09 04:54:35.317223) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 04:54:35.320924) ========= 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=923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871 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/Mozilla-Aurora-Non-PGO/sha512/336df2887176168452823b638811016b6ff904d50013467b9a9be30ac22906b700e62c106e818c72c7bee78c435420f37517cba28f8dd86e6f16ebe699bc159f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/1aa92fbe5dc10267828e73c2d7c4ceb362a79103f8fa82a8d7253a4d7164ed60adcaa7c7dd2fd651597012f97ef4df5ad9c87605da9757683c67616aeb224119", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b703ac3d6a095ea3a536b9ad23edc5ce8c72227924f9c18ad3925b6ffd4724321bc484e351806e775109d688780c61a560abf6bb4722b5d189e6da61c9146c4b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/775cc5e18d3bd1bf890431b7d5ba8f5575b0fd46c76a4bfcb9c9324456a7cc4daba6ca35bb3ed669bc5bc49971cd470ad6f9463542dd50c65209ff4f4a328d18"} build_url:https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011341 build_url: 'https://queue.taskcluster.net/v1/task/W34yO6bSTL-mVmlMyGW8LA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/336df2887176168452823b638811016b6ff904d50013467b9a9be30ac22906b700e62c106e818c72c7bee78c435420f37517cba28f8dd86e6f16ebe699bc159f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/1aa92fbe5dc10267828e73c2d7c4ceb362a79103f8fa82a8d7253a4d7164ed60adcaa7c7dd2fd651597012f97ef4df5ad9c87605da9757683c67616aeb224119", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/b703ac3d6a095ea3a536b9ad23edc5ce8c72227924f9c18ad3925b6ffd4724321bc484e351806e775109d688780c61a560abf6bb4722b5d189e6da61c9146c4b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/775cc5e18d3bd1bf890431b7d5ba8f5575b0fd46c76a4bfcb9c9324456a7cc4daba6ca35bb3ed669bc5bc49971cd470ad6f9463542dd50c65209ff4f4a328d18"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 04:54:35.345106) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 04:54:35.345417) ========= 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=923d835db2ba3686ebe126b700000192-1486643639.347682-1130225871 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 04:54:35.430688) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 04:54:35.431182) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 04:54:35.431713) ========= ========= Total master_lag: 0.16 =========