builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-035 starttime: 1484017962.2 results: success (0) revision: 8f3b24109e3412b36f97277e31ad66856dc609d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 19:12:42.200910) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-09 19:12:42.204766) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 19:12:42.205413) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-09 19:12:42.235699) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 19:12:42.236328) ========= 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=ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-09 19:12:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2017-01-09 19:12:42 (224 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127172 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 19:12:42.385984) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 19:12:42.386623) ========= 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=ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014179 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 19:12:42.457923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-09 19:12:42.458589) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8f3b24109e3412b36f97277e31ad66856dc609d6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 8f3b24109e3412b36f97277e31ad66856dc609d6 --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=ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-09 19:12:42,907 truncating revision to first 12 chars 2017-01-09 19:12:42,907 Setting DEBUG logging. 2017-01-09 19:12:42,907 attempt 1/10 2017-01-09 19:12:42,907 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8f3b24109e34?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-09 19:12:43,667 unpacking tar archive at: mozilla-central-8f3b24109e34/testing/mozharness/ program finished with exit code 0 elapsedTime=1.143624 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-09 19:12:43.623950) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 19:12:43.624554) ========= script_repo_revision: 8f3b24109e3412b36f97277e31ad66856dc609d6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-09 19:12:43.627945) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 19:12:43.628600) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-09 19:12:43.641139) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-01-09 19:12:43.641735) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:12:44 INFO - MultiFileLogger online at 20170109 19:12:44 in /builds/slave/test 19:12:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 19:12:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:12:44 INFO - {'append_to_log': False, 19:12:44 INFO - 'base_work_dir': '/builds/slave/test', 19:12:44 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 19:12:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:12:44 INFO - 'branch': 'Firefox-Non-PGO', 19:12:44 INFO - 'buildbot_json_path': 'buildprops.json', 19:12:44 INFO - 'config_files': ('talos/linux_config.py',), 19:12:44 INFO - 'default_actions': ('clobber', 19:12:44 INFO - 'read-buildbot-config', 19:12:44 INFO - 'download-and-extract', 19:12:44 INFO - 'populate-webroot', 19:12:44 INFO - 'create-virtualenv', 19:12:44 INFO - 'install', 19:12:44 INFO - 'run-tests'), 19:12:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:12:44 INFO - 'download_minidump_stackwalk': True, 19:12:44 INFO - 'download_symbols': 'ondemand', 19:12:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:12:44 INFO - 'tooltool.py': '/tools/tooltool.py', 19:12:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:12:44 INFO - '/tools/misc-python/virtualenv.py')}, 19:12:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:12:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:12:44 INFO - 'installer_path': 'installer.exe', 19:12:44 INFO - 'log_level': 'info', 19:12:44 INFO - 'log_name': 'talos', 19:12:44 INFO - 'log_to_console': True, 19:12:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:12:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:12:44 INFO - 'opt_config_files': (), 19:12:44 INFO - 'pip_index': False, 19:12:44 INFO - 'sps_profile': False, 19:12:44 INFO - 'sps_profile_interval': 0, 19:12:44 INFO - 'suite': 'dromaeojs-e10s', 19:12:44 INFO - 'system_bits': '32', 19:12:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:12:44 INFO - 'title': 'talos-linux64-ix-035', 19:12:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:12:44 INFO - 'use_talos_json': True, 19:12:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:12:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:12:44 INFO - 'work_dir': 'build'} 19:12:44 INFO - [mozharness: 2017-01-10 03:12:44.194158Z] Running clobber step. 19:12:44 INFO - Running pre-action listener: _resource_record_pre_action 19:12:44 INFO - Running main action method: clobber 19:12:44 INFO - rmtree: /builds/slave/test/build 19:12:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:12:44 INFO - Running post-action listener: _resource_record_post_action 19:12:44 INFO - [mozharness: 2017-01-10 03:12:44.663293Z] Finished clobber step (success) 19:12:44 INFO - [mozharness: 2017-01-10 03:12:44.663392Z] Running read-buildbot-config step. 19:12:44 INFO - Running pre-action listener: _resource_record_pre_action 19:12:44 INFO - Running main action method: read_buildbot_config 19:12:44 INFO - Using buildbot properties: 19:12:44 INFO - { 19:12:44 INFO - "project": "", 19:12:44 INFO - "product": "firefox", 19:12:44 INFO - "who": "philringnalda@gmail.com", 19:12:44 INFO - "installer_path": "public/build/target.tar.bz2", 19:12:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:12:44 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 19:12:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 19:12:44 INFO - "stage_platform": "linux64", 19:12:44 INFO - "basedir": "/builds/slave/test", 19:12:44 INFO - "buildnumber": 635, 19:12:44 INFO - "platform": "ubuntu64_hw", 19:12:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:12:44 INFO - "slavebuilddir": "test", 19:12:44 INFO - "taskId": "dgIe8DLmRn-T8-V6We8Wyg", 19:12:44 INFO - "branch": "mozilla-central", 19:12:44 INFO - "script_repo_revision": "production", 19:12:44 INFO - "revision": "8f3b24109e3412b36f97277e31ad66856dc609d6", 19:12:44 INFO - "slavename": "talos-linux64-ix-035", 19:12:44 INFO - "repo_path": "mozilla-central" 19:12:44 INFO - } 19:12:44 INFO - Finding installer, test and symbols from parent task. 19:12:44 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dgIe8DLmRn-T8-V6We8Wyg'}, attempt #1 19:12:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dgIe8DLmRn-T8-V6We8Wyg'}, attempt #1 19:12:45 INFO - Task dependencies: MjGhsuKhQDuTHYnhgCp9zQ 19:12:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ'}, attempt #1 19:12:46 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/target.tar.bz2 19:12:46 INFO - Set test_url: https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/test_packages.json 19:12:46 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/target.crashreporter-symbols.zip 19:12:46 INFO - Running post-action listener: _resource_record_post_action 19:12:46 INFO - [mozharness: 2017-01-10 03:12:46.049165Z] Finished read-buildbot-config step (success) 19:12:46 INFO - [mozharness: 2017-01-10 03:12:46.049382Z] Running download-and-extract step. 19:12:46 INFO - Running pre-action listener: _resource_record_pre_action 19:12:46 INFO - Running main action method: download_and_extract 19:12:46 INFO - mkdir: /builds/slave/test/build/tests 19:12:46 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')]} 19:12:46 INFO - trying https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/target.test_packages.json 19:12:46 INFO - Downloading https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:12:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:12:46 INFO - Downloaded 896 bytes. 19:12:46 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:12:46 INFO - Using the following test package requirements: 19:12:46 INFO - {u'common': [u'target.common.tests.zip'], 19:12:46 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:12:46 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:12:46 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:12:46 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:12:46 INFO - u'mozbase': [u'target.common.tests.zip'], 19:12:46 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:12:46 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:12:46 INFO - u'web-platform': [u'target.common.tests.zip', 19:12:46 INFO - u'target.web-platform.tests.zip'], 19:12:46 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:12:46 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:12:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/target.common.tests.zip 19:12:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:12:46 INFO - Fetch https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/target.common.tests.zip into memory 19:12:47 INFO - Expected file size: 20252653 19:12:47 INFO - Obtained file size: 20252653 19:12:51 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:12:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/target.common.tests.zip 19:12:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:12:51 INFO - Fetch https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/target.common.tests.zip into memory 19:12:52 INFO - Expected file size: 20252653 19:12:52 INFO - Obtained file size: 20252653 19:12:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/target.talos.tests.zip 19:12:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:12:56 INFO - Fetch https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/target.talos.tests.zip into memory 19:12:57 INFO - Expected file size: 14403537 19:12:57 INFO - Obtained file size: 14403537 19:12:57 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')]} 19:12:57 INFO - trying https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/target.tar.bz2 19:12:57 INFO - Downloading https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:12:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:12:58 INFO - Downloaded 55941439 bytes. 19:12:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/target.tar.bz2 19:12:58 INFO - mkdir: /builds/slave/test/properties 19:12:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:12:58 INFO - Writing to file /builds/slave/test/properties/build_url 19:12:58 INFO - Contents: 19:12:58 INFO - build_url:https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/target.tar.bz2 19:12:58 INFO - Running post-action listener: _resource_record_post_action 19:12:58 INFO - Running post-action listener: set_extra_try_arguments 19:12:58 INFO - [mozharness: 2017-01-10 03:12:58.899542Z] Finished download-and-extract step (success) 19:12:58 INFO - [mozharness: 2017-01-10 03:12:58.899640Z] Running populate-webroot step. 19:12:58 INFO - Running pre-action listener: _resource_record_pre_action 19:12:58 INFO - Running main action method: populate_webroot 19:12:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:12:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:12:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:12:58 INFO - '--tppagecycles', 19:12:58 INFO - '7'], 19:12:58 INFO - 'tests': ['tsvgm']}}, 19:12:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:12:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:12:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:12:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:12:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:12:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:12:58 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:12:58 INFO - 'talos_options': ['--disable-e10s'], 19:12:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:12:58 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:12:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:12:58 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:12:58 INFO - 'talos_options': ['--disable-e10s'], 19:12:58 INFO - 'tests': ['damp', 'tps']}, 19:12:58 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:12:58 INFO - 'tests': ['damp', 'tps']}, 19:12:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:12:58 INFO - 'tests': ['dromaeo_dom']}, 19:12:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:12:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:12:58 INFO - 'tests': ['basic_compositor_video']}, 19:12:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:12:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:12:58 INFO - 'tests': ['a11yr', 19:12:58 INFO - 'ts_paint', 19:12:58 INFO - 'tpaint', 19:12:58 INFO - 'sessionrestore', 19:12:58 INFO - 'sessionrestore_no_auto_restore', 19:12:58 INFO - 'tabpaint']}, 19:12:58 INFO - 'other-e10s': {'tests': ['a11yr', 19:12:58 INFO - 'ts_paint', 19:12:58 INFO - 'tpaint', 19:12:58 INFO - 'sessionrestore', 19:12:58 INFO - 'sessionrestore_no_auto_restore', 19:12:58 INFO - 'tabpaint']}, 19:12:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:12:58 INFO - 'ts_paint', 19:12:58 INFO - 'tpaint', 19:12:58 INFO - 'sessionrestore', 19:12:58 INFO - 'sessionrestore_no_auto_restore', 19:12:58 INFO - 'tabpaint']}, 19:12:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:12:58 INFO - 'ts_paint', 19:12:58 INFO - 'tpaint', 19:12:58 INFO - 'sessionrestore', 19:12:58 INFO - 'sessionrestore_no_auto_restore', 19:12:58 INFO - 'tabpaint']}, 19:12:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:12:58 INFO - 'tests': ['a11yr', 19:12:58 INFO - 'ts_paint', 19:12:58 INFO - 'tpaint', 19:12:58 INFO - 'sessionrestore', 19:12:58 INFO - 'sessionrestore_no_auto_restore', 19:12:58 INFO - 'tabpaint']}, 19:12:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:12:58 INFO - 'tests': ['a11yr', 19:12:58 INFO - 'ts_paint', 19:12:58 INFO - 'tpaint', 19:12:58 INFO - 'sessionrestore', 19:12:58 INFO - 'sessionrestore_no_auto_restore', 19:12:58 INFO - 'tabpaint']}, 19:12:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:12:58 INFO - 'tests': ['tsvgx', 19:12:58 INFO - 'tsvgr_opacity', 19:12:58 INFO - 'tart', 19:12:58 INFO - 'tscrollx', 19:12:58 INFO - 'cart', 19:12:58 INFO - 'tsvg_static']}, 19:12:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:12:58 INFO - 'tsvgr_opacity', 19:12:58 INFO - 'tart', 19:12:58 INFO - 'tscrollx', 19:12:58 INFO - 'cart', 19:12:58 INFO - 'tsvg_static']}, 19:12:58 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:12:58 INFO - 'talos_options': ['--disable-e10s'], 19:12:58 INFO - 'tests': ['tp5o']}, 19:12:58 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:12:58 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:12:58 INFO - 'talos_options': ['--disable-e10s', 19:12:58 INFO - '--xperf_path', 19:12:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:12:58 INFO - 'tests': ['tp5n']}, 19:12:58 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:12:58 INFO - 'talos_options': ['--xperf_path', 19:12:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:12:58 INFO - 'tests': ['tp5n']}}, 19:12:58 INFO - 'talos.zip': {'path': '', 19:12:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:12:58 INFO - Running post-action listener: _resource_record_post_action 19:12:58 INFO - [mozharness: 2017-01-10 03:12:58.912823Z] Finished populate-webroot step (success) 19:12:58 INFO - [mozharness: 2017-01-10 03:12:58.912914Z] Running create-virtualenv step. 19:12:58 INFO - Running pre-action listener: _resource_record_pre_action 19:12:58 INFO - Running main action method: create_virtualenv 19:12:58 INFO - Creating virtualenv /builds/slave/test/build/venv 19:12:58 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 19:12:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:12:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:12:59 INFO - Using real prefix '/usr' 19:12:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:12:59 INFO - Installing distribute.............................................................................................................................................................................................done. 19:13:01 INFO - Installing pip.................done. 19:13:01 INFO - Return code: 0 19:13:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:13:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:13:01 INFO - Reading from file tmpfile_stdout 19:13:01 INFO - Output received: 19:13:01 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) 19:13:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:13:01 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')]} 19:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:01 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')]} 19:13:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x18521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1963a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc1820>, '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 0x1bc2520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc29b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064', '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 19:13:01 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 19:13:01 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 19:13:01 INFO - Using env: {'DISPLAY': ':0', 19:13:01 INFO - 'HOME': '/home/cltbld', 19:13:01 INFO - 'LANG': 'en_US.UTF-8', 19:13:01 INFO - 'LANGUAGE': 'en_US:en', 19:13:01 INFO - 'LOGNAME': 'cltbld', 19:13:01 INFO - 'MAIL': '/var/mail/cltbld', 19:13:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:01 INFO - 'MOZ_NO_REMOTE': '1', 19:13:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:01 INFO - 'NO_EM_RESTART': '1', 19:13:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:01 INFO - 'PWD': '/builds/slave/test', 19:13:01 INFO - 'SHELL': '/bin/bash', 19:13:01 INFO - 'SHLVL': '1', 19:13:01 INFO - 'TERM': 'linux', 19:13:01 INFO - 'TMOUT': '86400', 19:13:01 INFO - 'USER': 'cltbld', 19:13:01 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064', 19:13:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:01 INFO - '_': '/tools/buildbot/bin/python'} 19:13:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:01 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 19:13:01 INFO - Cleaning up... 19:13:01 INFO - Return code: 0 19:13:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:13:01 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')]} 19:13:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:01 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')]} 19:13:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x18521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1963a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc1820>, '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 0x1bc2520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc29b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064', '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 19:13:01 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 19:13:01 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 19:13:01 INFO - Using env: {'DISPLAY': ':0', 19:13:01 INFO - 'HOME': '/home/cltbld', 19:13:01 INFO - 'LANG': 'en_US.UTF-8', 19:13:01 INFO - 'LANGUAGE': 'en_US:en', 19:13:01 INFO - 'LOGNAME': 'cltbld', 19:13:01 INFO - 'MAIL': '/var/mail/cltbld', 19:13:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:01 INFO - 'MOZ_NO_REMOTE': '1', 19:13:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:01 INFO - 'NO_EM_RESTART': '1', 19:13:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:01 INFO - 'PWD': '/builds/slave/test', 19:13:01 INFO - 'SHELL': '/bin/bash', 19:13:01 INFO - 'SHLVL': '1', 19:13:01 INFO - 'TERM': 'linux', 19:13:01 INFO - 'TMOUT': '86400', 19:13:01 INFO - 'USER': 'cltbld', 19:13:01 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064', 19:13:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:01 INFO - '_': '/tools/buildbot/bin/python'} 19:13:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:02 INFO - Downloading/unpacking psutil>=3.1.1 19:13:02 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 19:13:02 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 19:13:02 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 19:13:02 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 19:13:02 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 19:13:02 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 19:13:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:13:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:13:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:13:04 INFO - Installing collected packages: psutil 19:13:04 INFO - Running setup.py install for psutil 19:13:04 INFO - building 'psutil._psutil_linux' extension 19:13:04 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 19:13:04 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 19:13:04 INFO - building 'psutil._psutil_posix' extension 19:13:04 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 19:13:04 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 19:13:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:13:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:13:04 INFO - Successfully installed psutil 19:13:04 INFO - Cleaning up... 19:13:04 INFO - Return code: 0 19:13:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:13:04 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')]} 19:13:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:04 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')]} 19:13:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x18521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1963a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc1820>, '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 0x1bc2520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc29b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064', '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 19:13:04 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 19:13:04 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 19:13:04 INFO - Using env: {'DISPLAY': ':0', 19:13:04 INFO - 'HOME': '/home/cltbld', 19:13:04 INFO - 'LANG': 'en_US.UTF-8', 19:13:04 INFO - 'LANGUAGE': 'en_US:en', 19:13:04 INFO - 'LOGNAME': 'cltbld', 19:13:04 INFO - 'MAIL': '/var/mail/cltbld', 19:13:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:04 INFO - 'MOZ_NO_REMOTE': '1', 19:13:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:04 INFO - 'NO_EM_RESTART': '1', 19:13:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:04 INFO - 'PWD': '/builds/slave/test', 19:13:04 INFO - 'SHELL': '/bin/bash', 19:13:04 INFO - 'SHLVL': '1', 19:13:04 INFO - 'TERM': 'linux', 19:13:04 INFO - 'TMOUT': '86400', 19:13:04 INFO - 'USER': 'cltbld', 19:13:04 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064', 19:13:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:04 INFO - '_': '/tools/buildbot/bin/python'} 19:13:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:05 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 19:13:05 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 19:13:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:13:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:13:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:13:07 INFO - Installing collected packages: mozsystemmonitor 19:13:07 INFO - Running setup.py install for mozsystemmonitor 19:13:07 INFO - Successfully installed mozsystemmonitor 19:13:07 INFO - Cleaning up... 19:13:07 INFO - Return code: 0 19:13:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:13:07 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')]} 19:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:07 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')]} 19:13:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x18521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1963a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc1820>, '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 0x1bc2520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc29b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064', '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 19:13:07 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 19:13:07 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 19:13:07 INFO - Using env: {'DISPLAY': ':0', 19:13:07 INFO - 'HOME': '/home/cltbld', 19:13:07 INFO - 'LANG': 'en_US.UTF-8', 19:13:07 INFO - 'LANGUAGE': 'en_US:en', 19:13:07 INFO - 'LOGNAME': 'cltbld', 19:13:07 INFO - 'MAIL': '/var/mail/cltbld', 19:13:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:07 INFO - 'MOZ_NO_REMOTE': '1', 19:13:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:07 INFO - 'NO_EM_RESTART': '1', 19:13:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:07 INFO - 'PWD': '/builds/slave/test', 19:13:07 INFO - 'SHELL': '/bin/bash', 19:13:07 INFO - 'SHLVL': '1', 19:13:07 INFO - 'TERM': 'linux', 19:13:07 INFO - 'TMOUT': '86400', 19:13:07 INFO - 'USER': 'cltbld', 19:13:07 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064', 19:13:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:07 INFO - '_': '/tools/buildbot/bin/python'} 19:13:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:07 INFO - Downloading/unpacking jsonschema==2.5.1 19:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:07 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 19:13:07 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 19:13:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:13:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:09 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 19:13:09 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 19:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:09 INFO - Downloading functools32-3.2.3-2.tar.gz 19:13:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:13:09 INFO - warning: no files found matching '*.txt' 19:13:09 INFO - no previously-included directories found matching 'build' 19:13:09 INFO - no previously-included directories found matching 'dist' 19:13:09 INFO - no previously-included directories found matching '.git*' 19:13:09 INFO - Installing collected packages: jsonschema, functools32 19:13:09 INFO - Running setup.py install for functools32 19:13:09 INFO - warning: no files found matching '*.txt' 19:13:09 INFO - no previously-included directories found matching 'build' 19:13:09 INFO - no previously-included directories found matching 'dist' 19:13:09 INFO - no previously-included directories found matching '.git*' 19:13:09 INFO - Successfully installed jsonschema functools32 19:13:09 INFO - Cleaning up... 19:13:09 INFO - Return code: 0 19:13:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:13:09 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')]} 19:13:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:09 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')]} 19:13:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x18521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1963a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc1820>, '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 0x1bc2520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc29b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064', '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 19:13:09 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 19:13:09 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 19:13:09 INFO - Using env: {'DISPLAY': ':0', 19:13:09 INFO - 'HOME': '/home/cltbld', 19:13:09 INFO - 'LANG': 'en_US.UTF-8', 19:13:09 INFO - 'LANGUAGE': 'en_US:en', 19:13:09 INFO - 'LOGNAME': 'cltbld', 19:13:09 INFO - 'MAIL': '/var/mail/cltbld', 19:13:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:09 INFO - 'MOZ_NO_REMOTE': '1', 19:13:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:09 INFO - 'NO_EM_RESTART': '1', 19:13:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:09 INFO - 'PWD': '/builds/slave/test', 19:13:09 INFO - 'SHELL': '/bin/bash', 19:13:09 INFO - 'SHLVL': '1', 19:13:09 INFO - 'TERM': 'linux', 19:13:09 INFO - 'TMOUT': '86400', 19:13:09 INFO - 'USER': 'cltbld', 19:13:09 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064', 19:13:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:09 INFO - '_': '/tools/buildbot/bin/python'} 19:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:13:10 INFO - Cleaning up... 19:13:10 INFO - Return code: 0 19:13:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:13:10 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')]} 19:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:10 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')]} 19:13:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x18521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1963a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc1820>, '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 0x1bc2520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc29b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064', '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 19:13:10 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 19:13:10 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 19:13:10 INFO - Using env: {'DISPLAY': ':0', 19:13:10 INFO - 'HOME': '/home/cltbld', 19:13:10 INFO - 'LANG': 'en_US.UTF-8', 19:13:10 INFO - 'LANGUAGE': 'en_US:en', 19:13:10 INFO - 'LOGNAME': 'cltbld', 19:13:10 INFO - 'MAIL': '/var/mail/cltbld', 19:13:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:10 INFO - 'MOZ_NO_REMOTE': '1', 19:13:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:10 INFO - 'NO_EM_RESTART': '1', 19:13:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:10 INFO - 'PWD': '/builds/slave/test', 19:13:10 INFO - 'SHELL': '/bin/bash', 19:13:10 INFO - 'SHLVL': '1', 19:13:10 INFO - 'TERM': 'linux', 19:13:10 INFO - 'TMOUT': '86400', 19:13:10 INFO - 'USER': 'cltbld', 19:13:10 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064', 19:13:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:10 INFO - '_': '/tools/buildbot/bin/python'} 19:13:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:10 INFO - Downloading/unpacking blobuploader==1.2.4 19:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:10 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 19:13:10 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 19:13:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:12 INFO - Downloading blobuploader-1.2.4.tar.gz 19:13:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:13:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:12 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 19:13:12 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 19:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:13:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:12 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 19:13:12 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 19:13:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:13 INFO - Downloading docopt-0.6.1.tar.gz 19:13:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:13:13 INFO - Installing collected packages: blobuploader, requests, docopt 19:13:13 INFO - Running setup.py install for blobuploader 19:13:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:13:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:13:13 INFO - Running setup.py install for requests 19:13:13 INFO - Running setup.py install for docopt 19:13:13 INFO - Successfully installed blobuploader requests docopt 19:13:13 INFO - Cleaning up... 19:13:13 INFO - Return code: 0 19:13:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:13:13 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')]} 19:13:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:13 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')]} 19:13:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x18521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1963a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc1820>, '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 0x1bc2520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc29b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064', '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 19:13:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 19:13:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.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 19:13:13 INFO - Using env: {'DISPLAY': ':0', 19:13:13 INFO - 'HOME': '/home/cltbld', 19:13:13 INFO - 'LANG': 'en_US.UTF-8', 19:13:13 INFO - 'LANGUAGE': 'en_US:en', 19:13:13 INFO - 'LOGNAME': 'cltbld', 19:13:13 INFO - 'MAIL': '/var/mail/cltbld', 19:13:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:13 INFO - 'MOZ_NO_REMOTE': '1', 19:13:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:13 INFO - 'NO_EM_RESTART': '1', 19:13:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:13 INFO - 'PWD': '/builds/slave/test', 19:13:13 INFO - 'SHELL': '/bin/bash', 19:13:13 INFO - 'SHLVL': '1', 19:13:13 INFO - 'TERM': 'linux', 19:13:13 INFO - 'TMOUT': '86400', 19:13:13 INFO - 'USER': 'cltbld', 19:13:13 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064', 19:13:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:13 INFO - '_': '/tools/buildbot/bin/python'} 19:13:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:13:14 INFO - Running setup.py (path:/tmp/pip-kYZ_IG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:13:14 INFO - Running setup.py (path:/tmp/pip-VIpUUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:13:14 INFO - Running setup.py (path:/tmp/pip-p5pJQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:13:14 INFO - Running setup.py (path:/tmp/pip-5S0_qM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:13:14 INFO - Running setup.py (path:/tmp/pip-cnaDL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:13:14 INFO - Running setup.py (path:/tmp/pip-awNX9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:13:14 INFO - Running setup.py (path:/tmp/pip-SnGzoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:13:14 INFO - Running setup.py (path:/tmp/pip-M8C1Ea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:13:14 INFO - Running setup.py (path:/tmp/pip-bvw8Nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:13:14 INFO - Running setup.py (path:/tmp/pip-8Y1lPe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:13:14 INFO - Running setup.py (path:/tmp/pip-aQvxwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:13:14 INFO - Running setup.py (path:/tmp/pip-bZFaiG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:13:14 INFO - Running setup.py (path:/tmp/pip-SOe2Mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:13:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:13:15 INFO - Running setup.py (path:/tmp/pip-OMI6rl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:13:15 INFO - Running setup.py (path:/tmp/pip-rGR1c5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:13:15 INFO - Running setup.py (path:/tmp/pip-fe7DdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:13:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:13:15 INFO - Running setup.py (path:/tmp/pip-rPXT47-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:13:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:13:15 INFO - Running setup.py install for manifestparser 19:13:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:13:15 INFO - Running setup.py install for mozcrash 19:13:15 INFO - Running setup.py install for mozdebug 19:13:15 INFO - Running setup.py install for mozdevice 19:13:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:13:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:13:15 INFO - Running setup.py install for mozfile 19:13:15 INFO - Running setup.py install for mozhttpd 19:13:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:13:15 INFO - Running setup.py install for mozinfo 19:13:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:13:16 INFO - Running setup.py install for mozInstall 19:13:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:13:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:13:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:13:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:13:16 INFO - Running setup.py install for mozleak 19:13:16 INFO - Running setup.py install for mozlog 19:13:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:13:16 INFO - Running setup.py install for moznetwork 19:13:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:13:16 INFO - Running setup.py install for mozprocess 19:13:16 INFO - Running setup.py install for mozprofile 19:13:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:13:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:13:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:13:16 INFO - Running setup.py install for mozrunner 19:13:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:13:16 INFO - Running setup.py install for mozscreenshot 19:13:16 INFO - Running setup.py install for moztest 19:13:16 INFO - Running setup.py install for mozversion 19:13:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:13:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:13:17 INFO - Cleaning up... 19:13:17 INFO - Return code: 0 19:13:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:13:17 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')]} 19:13:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:17 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')]} 19:13:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:17 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 0x18521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1963a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc1820>, '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 0x1bc2520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc29b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064', '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 19:13:17 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 19:13:17 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 19:13:17 INFO - Using env: {'DISPLAY': ':0', 19:13:17 INFO - 'HOME': '/home/cltbld', 19:13:17 INFO - 'LANG': 'en_US.UTF-8', 19:13:17 INFO - 'LANGUAGE': 'en_US:en', 19:13:17 INFO - 'LOGNAME': 'cltbld', 19:13:17 INFO - 'MAIL': '/var/mail/cltbld', 19:13:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:17 INFO - 'MOZ_NO_REMOTE': '1', 19:13:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:17 INFO - 'NO_EM_RESTART': '1', 19:13:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:17 INFO - 'PWD': '/builds/slave/test', 19:13:17 INFO - 'SHELL': '/bin/bash', 19:13:17 INFO - 'SHLVL': '1', 19:13:17 INFO - 'TERM': 'linux', 19:13:17 INFO - 'TMOUT': '86400', 19:13:17 INFO - 'USER': 'cltbld', 19:13:17 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064', 19:13:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:17 INFO - '_': '/tools/buildbot/bin/python'} 19:13:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:13:17 INFO - Running setup.py (path:/tmp/pip-1ULqCE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:13:17 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)) 19:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:13:17 INFO - Running setup.py (path:/tmp/pip-N1XnET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:13:17 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)) 19:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:13:17 INFO - Running setup.py (path:/tmp/pip-85PXoW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:13:17 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)) 19:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:13:17 INFO - Running setup.py (path:/tmp/pip-4kUwUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:13:17 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)) 19:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:13:17 INFO - Running setup.py (path:/tmp/pip-6ZqnkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:13:17 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)) 19:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:13:17 INFO - Running setup.py (path:/tmp/pip-W_If7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:13:17 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)) 19:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:13:17 INFO - Running setup.py (path:/tmp/pip-ZcAh2_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:13:17 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)) 19:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:13:17 INFO - Running setup.py (path:/tmp/pip-qtl3Tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:13:17 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)) 19:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:13:17 INFO - Running setup.py (path:/tmp/pip-lhewAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:13:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:13:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:13:17 INFO - Running setup.py (path:/tmp/pip-WEtzvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:13:18 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)) 19:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:13:18 INFO - Running setup.py (path:/tmp/pip-zgIeN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:13:18 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)) 19:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:13:18 INFO - Running setup.py (path:/tmp/pip-zsVTGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:13:18 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)) 19:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:13:18 INFO - Running setup.py (path:/tmp/pip-sDcOhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:13:18 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)) 19:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:13:18 INFO - Running setup.py (path:/tmp/pip-6nhfWu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:13:18 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)) 19:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:13:18 INFO - Running setup.py (path:/tmp/pip-IVsoKG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:13:18 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)) 19:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:13:18 INFO - Running setup.py (path:/tmp/pip-aDQjiB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:13:18 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)) 19:13:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:13:18 INFO - Running setup.py (path:/tmp/pip-lmFpxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:13:18 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)) 19:13:18 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)) 19:13:18 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)) 19:13:18 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)) 19:13:18 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)) 19:13:18 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)) 19:13:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:18 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 19:13:18 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 19:13:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:13:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:13:20 INFO - Downloading blessings-1.6.tar.gz 19:13:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:13:20 INFO - Installing collected packages: blessings 19:13:20 INFO - Running setup.py install for blessings 19:13:20 INFO - Successfully installed blessings 19:13:20 INFO - Cleaning up... 19:13:20 INFO - Return code: 0 19:13:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:13:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:13:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:13:21 INFO - Reading from file tmpfile_stdout 19:13:21 INFO - Current package versions: 19:13:21 INFO - argparse == 1.2.1 19:13:21 INFO - blessings == 1.6 19:13:21 INFO - blobuploader == 1.2.4 19:13:21 INFO - docopt == 0.6.1 19:13:21 INFO - functools32 == 3.2.3-2 19:13:21 INFO - jsonschema == 2.5.1 19:13:21 INFO - manifestparser == 1.1 19:13:21 INFO - mozInstall == 1.12 19:13:21 INFO - mozcrash == 1.0 19:13:21 INFO - mozdebug == 0.1 19:13:21 INFO - mozdevice == 0.49 19:13:21 INFO - mozfile == 1.2 19:13:21 INFO - mozhttpd == 0.7 19:13:21 INFO - mozinfo == 0.9 19:13:21 INFO - mozleak == 0.1 19:13:21 INFO - mozlog == 3.4 19:13:21 INFO - moznetwork == 0.27 19:13:21 INFO - mozprocess == 0.24 19:13:21 INFO - mozprofile == 0.28 19:13:21 INFO - mozrunner == 6.13 19:13:21 INFO - mozscreenshot == 0.1 19:13:21 INFO - mozsystemmonitor == 0.3 19:13:21 INFO - moztest == 0.8 19:13:21 INFO - mozversion == 1.4 19:13:21 INFO - psutil == 3.1.1 19:13:21 INFO - requests == 1.2.3 19:13:21 INFO - wsgiref == 0.1.2 19:13:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:13:21 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')]} 19:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:21 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')]} 19:13:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:21 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 0x18521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1963a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc1820>, '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 0x1bc2520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc29b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064', '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 19:13:21 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 19:13:21 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 19:13:21 INFO - Using env: {'DISPLAY': ':0', 19:13:21 INFO - 'HOME': '/home/cltbld', 19:13:21 INFO - 'LANG': 'en_US.UTF-8', 19:13:21 INFO - 'LANGUAGE': 'en_US:en', 19:13:21 INFO - 'LOGNAME': 'cltbld', 19:13:21 INFO - 'MAIL': '/var/mail/cltbld', 19:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:21 INFO - 'MOZ_NO_REMOTE': '1', 19:13:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:21 INFO - 'NO_EM_RESTART': '1', 19:13:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:21 INFO - 'PWD': '/builds/slave/test', 19:13:21 INFO - 'SHELL': '/bin/bash', 19:13:21 INFO - 'SHLVL': '1', 19:13:21 INFO - 'TERM': 'linux', 19:13:21 INFO - 'TMOUT': '86400', 19:13:21 INFO - 'USER': 'cltbld', 19:13:21 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064', 19:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:21 INFO - '_': '/tools/buildbot/bin/python'} 19:13:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:21 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)) 19:13:21 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)) 19:13:21 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)) 19:13:21 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)) 19:13:21 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)) 19:13:21 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)) 19:13:21 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)) 19:13:21 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)) 19:13:21 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)) 19:13:21 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)) 19:13:21 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)) 19:13:21 INFO - Cleaning up... 19:13:21 INFO - Return code: 0 19:13:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:13:21 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')]} 19:13:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:13:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:21 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')]} 19:13:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:13:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:13:21 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 0x18521f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1963a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bc4480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bc1820>, '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 0x1bc2520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc29b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064', '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 19:13:21 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 19:13:21 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 19:13:21 INFO - Using env: {'DISPLAY': ':0', 19:13:21 INFO - 'HOME': '/home/cltbld', 19:13:21 INFO - 'LANG': 'en_US.UTF-8', 19:13:21 INFO - 'LANGUAGE': 'en_US:en', 19:13:21 INFO - 'LOGNAME': 'cltbld', 19:13:21 INFO - 'MAIL': '/var/mail/cltbld', 19:13:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:21 INFO - 'MOZ_NO_REMOTE': '1', 19:13:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:21 INFO - 'NO_EM_RESTART': '1', 19:13:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:21 INFO - 'PWD': '/builds/slave/test', 19:13:21 INFO - 'SHELL': '/bin/bash', 19:13:21 INFO - 'SHLVL': '1', 19:13:21 INFO - 'TERM': 'linux', 19:13:21 INFO - 'TMOUT': '86400', 19:13:21 INFO - 'USER': 'cltbld', 19:13:21 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064', 19:13:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:21 INFO - '_': '/tools/buildbot/bin/python'} 19:13:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:13:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:13:21 INFO - Cleaning up... 19:13:21 INFO - Return code: 0 19:13:21 INFO - Running post-action listener: _resource_record_post_action 19:13:21 INFO - Running post-action listener: _start_resource_monitoring 19:13:21 INFO - Starting resource monitoring. 19:13:21 INFO - [mozharness: 2017-01-10 03:13:21.535700Z] Finished create-virtualenv step (success) 19:13:21 INFO - [mozharness: 2017-01-10 03:13:21.536213Z] Running install step. 19:13:21 INFO - Running pre-action listener: _resource_record_pre_action 19:13:21 INFO - Running main action method: install 19:13:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:13:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:13:21 INFO - Reading from file tmpfile_stdout 19:13:21 INFO - Detecting whether we're running mozinstall >=1.0... 19:13:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:13:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:13:21 INFO - Reading from file tmpfile_stdout 19:13:21 INFO - Output received: 19:13:21 INFO - Usage: mozinstall [options] installer 19:13:21 INFO - Options: 19:13:21 INFO - -h, --help show this help message and exit 19:13:21 INFO - -d DEST, --destination=DEST 19:13:21 INFO - Directory to install application into. [default: 19:13:21 INFO - "/builds/slave/test"] 19:13:21 INFO - --app=APP Application being installed. [default: firefox] 19:13:21 INFO - mkdir: /builds/slave/test/build/application 19:13:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:13:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:13:37 INFO - Reading from file tmpfile_stdout 19:13:37 INFO - Output received: 19:13:37 INFO - /builds/slave/test/build/application/firefox/firefox 19:13:37 INFO - Running post-action listener: _resource_record_post_action 19:13:37 INFO - [mozharness: 2017-01-10 03:13:37.908323Z] Finished install step (success) 19:13:37 INFO - [mozharness: 2017-01-10 03:13:37.908597Z] Running run-tests step. 19:13:37 INFO - Running pre-action listener: _resource_record_pre_action 19:13:37 INFO - Running main action method: run_tests 19:13:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:13:37 INFO - Python 2.7.3 19:13:37 INFO - Return code: 0 19:13:37 INFO - grabbing minidump binary from tooltool 19:13:37 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')]} 19:13:37 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 0x1bc1820>, '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 0x1bc2520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bc29b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:13:37 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 19:13:37 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 19:13:37 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 19:13:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:13:37 INFO - Return code: 0 19:13:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:13:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:13:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:13:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:13:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:13:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 19:13:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 19:13:37 INFO - Using env: {'DISPLAY': ':0', 19:13:37 INFO - 'HOME': '/home/cltbld', 19:13:37 INFO - 'LANG': 'en_US.UTF-8', 19:13:37 INFO - 'LANGUAGE': 'en_US:en', 19:13:37 INFO - 'LOGNAME': 'cltbld', 19:13:37 INFO - 'MAIL': '/var/mail/cltbld', 19:13:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:13:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:13:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:13:37 INFO - 'MOZ_NO_REMOTE': '1', 19:13:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:13:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:13:37 INFO - 'NO_EM_RESTART': '1', 19:13:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:13:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:13:37 INFO - 'PWD': '/builds/slave/test', 19:13:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:13:37 INFO - 'SHELL': '/bin/bash', 19:13:37 INFO - 'SHLVL': '1', 19:13:37 INFO - 'TERM': 'linux', 19:13:37 INFO - 'TMOUT': '86400', 19:13:37 INFO - 'USER': 'cltbld', 19:13:37 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064', 19:13:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:13:37 INFO - '_': '/tools/buildbot/bin/python'} 19:13:37 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 19:13:38 INFO - mozversion application_buildid: 20170110024225 19:13:38 INFO - mozversion application_changeset: 8f3b24109e3412b36f97277e31ad66856dc609d6 19:13:38 INFO - mozversion application_display_name: Nightly 19:13:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:13:38 INFO - mozversion application_name: Firefox 19:13:38 INFO - mozversion application_remotingname: firefox 19:13:38 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:13:38 INFO - mozversion application_vendor: Mozilla 19:13:38 INFO - mozversion application_version: 53.0a1 19:13:38 INFO - mozversion platform_buildid: 20170110024225 19:13:38 INFO - mozversion platform_changeset: 8f3b24109e3412b36f97277e31ad66856dc609d6 19:13:38 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:13:38 INFO - mozversion platform_version: 53.0a1 19:13:38 INFO - using testdate: 1484018018 19:13:38 INFO - actual date: 1484018018 19:13:38 INFO - starting webserver on 'localhost:54837' 19:13:38 INFO - SUITE-START | Running 2 tests 19:13:38 INFO - TEST-START | dromaeo_css 19:13:38 INFO - operating with platform_type : linux_ 19:13:38 INFO - Initialising browser for dromaeo_css test... 19:13:38 INFO - TEST-INFO | started process 10017 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsHDz_7/profile http://localhost:54837/getInfo.html) 19:13:38 INFO - PROCESS | 10017 | 1484018018667 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4906 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3761 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2794 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 19:13:42 INFO - PROCESS | 10017 | __metrics Screen width/height:1600/1200 19:13:42 INFO - PROCESS | 10017 | colorDepth:24 19:13:42 INFO - PROCESS | 10017 | Browser inner width/height: 1024/697 19:13:42 INFO - PROCESS | 10017 | __metrics 19:13:43 ERROR - PROCESS | 10017 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 19:13:43 INFO - TEST-INFO | 10017: exit 0 19:13:43 INFO - Browser initialized. 19:13:43 INFO - Running cycle 1/1 for dromaeo_css test... 19:13:43 INFO - TEST-INFO | started process 10138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsHDz_7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:13:55 INFO - PROCESS | 10138 | RSS: Main: 159404032 19:13:55 INFO - PROCESS | 10138 | 19:16:59 INFO - PROCESS | 10138 | Cycle 1(1): loaded http://localhost:54837/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54837/tests/dromaeo/cssquery-ext.html) 19:17:00 INFO - PROCESS | 10138 | RSS: Main: 166703104 19:17:00 INFO - PROCESS | 10138 | 19:18:44 INFO - PROCESS | 10138 | ************************* 19:18:44 INFO - PROCESS | 10138 | A coding exception was thrown and uncaught in a Task. 19:18:44 INFO - PROCESS | 10138 | 19:18:44 INFO - PROCESS | 10138 | Full message: ReferenceError: fetch is not defined 19:18:44 INFO - PROCESS | 10138 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 19:18:44 INFO - PROCESS | 10138 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 19:18:44 INFO - PROCESS | 10138 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 19:18:44 INFO - PROCESS | 10138 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 19:18:44 INFO - PROCESS | 10138 | TaskImpl@resource://gre/modules/Task.jsm:277:3 19:18:44 INFO - PROCESS | 10138 | asyncFunction@resource://gre/modules/Task.jsm:252:14 19:18:44 INFO - PROCESS | 10138 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 19:18:44 INFO - PROCESS | 10138 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 19:18:44 INFO - PROCESS | 10138 | TaskImpl@resource://gre/modules/Task.jsm:277:3 19:18:44 INFO - PROCESS | 10138 | asyncFunction@resource://gre/modules/Task.jsm:252:14 19:18:44 INFO - PROCESS | 10138 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 19:18:44 INFO - PROCESS | 10138 | 19:18:44 INFO - PROCESS | 10138 | ************************* 19:20:03 INFO - PROCESS | 10138 | Cycle 1(1): loaded http://localhost:54837/tests/dromaeo/cssquery-ext.html (next: http://localhost:54837/tests/dromaeo/cssquery-jquery.html) 19:20:03 INFO - PROCESS | 10138 | RSS: Main: 163794944 19:20:03 INFO - PROCESS | 10138 | 19:23:05 INFO - PROCESS | 10138 | Cycle 1(1): loaded http://localhost:54837/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54837/tests/dromaeo/cssquery-mootools.html) 19:23:06 INFO - PROCESS | 10138 | RSS: Main: 168177664 19:23:06 INFO - PROCESS | 10138 | 19:26:08 INFO - PROCESS | 10138 | Cycle 1(1): loaded http://localhost:54837/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54837/tests/dromaeo/cssquery-prototype.html) 19:26:09 INFO - PROCESS | 10138 | RSS: Main: 163692544 19:26:09 INFO - PROCESS | 10138 | 19:29:12 INFO - PROCESS | 10138 | Cycle 1(1): loaded http://localhost:54837/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54837/tests/dromaeo/cssquery-yui.html) 19:29:12 INFO - PROCESS | 10138 | RSS: Main: 166621184 19:29:12 INFO - PROCESS | 10138 | 19:32:15 INFO - PROCESS | 10138 | Cycle 1(1): loaded http://localhost:54837/tests/dromaeo/cssquery-yui.html (next: http://localhost:54837/tests/dromaeo/cssquery-dojo.html) 19:32:16 INFO - PROCESS | 10138 | RSS: Main: 167698432 19:32:16 INFO - PROCESS | 10138 | 19:32:16 INFO - PROCESS | 10138 | __start_tp_report 19:32:16 INFO - PROCESS | 10138 | _x_x_mozilla_page_load 19:32:16 INFO - PROCESS | 10138 | _x_x_mozilla_page_load_details 19:32:16 INFO - PROCESS | 10138 | |i|pagename|runs| 19:32:16 INFO - PROCESS | 10138 | |0;dojo.html;2587.391962888721;2588.7022992355874;2589.1585234798695;2613.2160351894427;2621.2660455072587;4672.439307283131;4721.645876559259;4731.43222813262;4747.240441529351;4760.738159401231;4703.670743047979;4735.50277220892;4754.239321708527;4776.331313616097;4790.401199850019;4323.135372925428;4351.934720979196;4398.098389830093;4430.712003719748;4467.352233926079;4396.186705459484;4436.378906953013;4493.191225579394;4510.368548403226;4532.864014079566;4323.789338985089;4333.848315308981;4369.060651959844;4401.779911004437;4437.356583295404;4344.782760861945;4375.606195442426;4391.692581519295;4409.559044095565;4425.7565833879125;4328.2209202343565;4329.06925011121;4352.303631418989;4372.322290045016;4409.4488188976375;4633.49031606523;4665.720056796603;4677.204875171229;4721.457032441244;4735.73953432561;4995.9250611240495;5063.316452278932;5082.949170508285;5108.3359163308905;5135.666181698178;5106.106431374495;5109.386873575195;5113.130767769451;5125.9257779531;5130.53825155734;4786.282057691375;4787.54518320759;4800.4479484859685;4825.20384136617;4825.30033145192;5117.590592752571;5165.66423182492;5170.1469257572835;5177.145770947752;5199.856031673025;5001.049800537886;5023.372078490189;5024.145895197825;5036.420811606712;5038.823641172541;4958.652894297436;5092.414372347227;5113.64204505681;5116.334876466036;5125.410577783528;4988.775505102279;4991.800327986913;5019.347484826949;5039.722815245197;5088.414832294259;5044.672096313728;5051.722155281422;5056.469070747592;5063.696178229245;5095.15929871567;4311.8706438806885;4335.609795118455;4339.956600433955;4343.5656434356315;4385.956140438619;3721.1813401051727;3730.1420673245307;3740.2893450244364;3749.6250374962287;3812.5996770338716;4387.890302742393;4388.780560972003;4397.0546332538015;4426.070525189746;4429.224885645063;5122.257272695439;5126.4617215191865;5130.717810520383;5134.204198349262;5139.152039913372;4337.306031035019;4351.760653164043;4388.605025547716;4388.626966707801;4419.248727716296;4599.126166028444;4623.375844261049;4628.907421851612;4668.626509879202;4680.157571637138;4795.736234507136;4796.040791841576;4808.3989501312335;4829.782659780319;4853.757312134449;5061.9493805061475;5084.491550844886;5130.050940576006;5133.998870220271;5137.974310128575;4775.689580177277;4786.44955830084;4797.832075877328;4828.734419606955;4840.6127509798425;5025.170846810235;5029.497050294941;5034.899302013866;5051.520105589963;5083.593312534915;5018.372703412074;5072.213806859942;5117.641765076409;5139.126348520836;5181.766820493162;4917.852464426073;4935.259711043373;4948.035133149146;4964.851054468371;4985.052839960396;4906.313116163668;4948.837023299594;4950.801967921243;4956.330895329229;5009.574186194069;4746.691465054761;4823.2282834747675;4836.395450568679;4911.066897289504;4930.852074437773;4915.483874193301;4963.10664080469;4977.552020318189;4995.150824359795;4997.625178111583;4879.487653796442;4881.9023619528125;4912.680675756064;4955.628327875496;4972.900541989212 19:32:16 INFO - PROCESS | 10138 | |1;ext.html;516.8397796683029;522.0889547739196;530.7744208711297;532.5473347654494;542.7557599080415;38670.419943700865;40725.3891191632;40765.79617101914;44653.10693786122;44971.55028449715;41373;41856;41865;41948.91740697597;41968.160636787245;7785.688572457095;7940.602969851513;7941.20587941207;7950.0857401399;9654.324197306192;9490.145886870181;9782.413055216673;9789.412635241873;9810.656627018056;9810.705678829647;9766.609335626603;9788.95105524475;9823.50882455878;9861.359011664255;9873.259505537078;9821.803563928717;9837.360571562825;9842.409455432697;9857.753556161153;9874.407535547818;9710.805783884354;9729.075737804897;9737.951310243474;9776.755581110458;9786.657466988692;34033.31933361319;34213.82893085544;34314.6568534314;34361.48457773135;34468.82765586181;3564.198055437532;3635.0912271932016;3643.544556930384;3670.284294562561;3697.6856967157555;24178.153764618153;24210.878945605335;24280.63579046316;24439.26682199537;24897.62653560198;3433.6051354094348;3440.3291358185165;3487.7907325560545;3642.253338065717;3644.6902013328636;239225;240146;240396;241337;242787;46016.07967840692;46334.536654633695;46336.7683161582;46343;46399.53600463952;46904.29643555349;47017.529824702;47122.29316560255;47303.29045064327;47311.5268847314;11895.286282823059;12108.81836772449;12143.332116733665;12174.756504869853;12192.756144877052;8700.390972631854;8830.116988301119;9128.178463938277;9294.117058879396;9355.95322023399;15648;15709.507596778289;15802.60493487649;15859.52421427359;15925.601859953595;6433.485321174295;6460.192475940507;6544.3782840630065;6546.967265163644;6618.735250590019;729.4237552333703;754.0498971296097;765.3991616580957;765.6324964017302;778.7507997440764;26547.336316591853;27714.5842812358;27920.441591168063;28135.859320703676;28268.293292667848;863.77061102124;906.8301890561235;912.926965842731;913.182701482183;922.2437601166979;13604.606449228655;14583.718663300673;14867.776983345258;14965.251737413086;15026.774598381033;340604;355853;362488;364133;562841;43433.34849977253;44042;44278.11443771107;44297;44544.3318350225;1208.0939295528353;1229.305442425045;1240.5347994502063;1240.8697086805937;1247.5134697467995;25058.874705626356;25564.48871022532;26456.86771566207;26540.601890972037;26780.732192677824;37884.81057594695;38260;38316.61683383242;38321.23357532778;38352.42471362876;322728;325114;325529;327145;327308;23230.883845580665;23600.645990309815;23613.812135361506;23872.403189919696;25527.234182974542;36581;36935.815320923226;37142;37239.255214895005;37267;29758;31378.686213137575;31894.52158217582;32158.678413216505;32321.51517727189;30953;32183;32451.35097298088;32699.836500817342;33292.16769580683;31334.373312534077;32119.357612847143;32489;32524.83737581297;32545.511817322287;28220.294492637848;29754.553681695226;30071.248218794706;30274;30390;22934;23113.5928241533;23238.3028509145;23333.883330583918;23369 19:32:16 INFO - PROCESS | 10138 | |2;jquery.html;330.16303670196044;338.95932488101425;341.4093618040789;354.061736398544;361.88419705694173;17260.309587616495;17847.375341863037;18187;18393.63212735748;18407.815921840778;17316.567085822862;17617.471475855746;18036;18129.184186711598;18135.72796408055;5067.771950262247;5222.086134926391;5256.526912577867;5256.9474305256845;5257.447967963366;5056.115179843531;5158.458361871987;5227.503387178231;5240.502152295526;5246.606504512158;5160.122779127539;5187.144121220013;5201.375834899817;5216.295800067;5220.504052115043;5171.5862730981435;5187.3775146982225;5199.818006369778;5199.896002079956;5226.947730522722;5303.814366497154;5413.864653383657;5415.675059496442;5425.565954723652;5430.484104010113;10757.731056723565;10775.5689772409;15268.25171469135;21827.345179644635;22002.88998554997;1998.5902889907534;2036.857419980587;2074.159965214076;2101.684747287904;2147.3450597567735;8896.733098007071;9063.546822658907;9072.682456114071;9232.353735238536;9407.576659050359;1685.9494215173565;1744.1105036431384;1773.5743421578857;1783.9018853963028;1787.3833527433014;75114.62442687806;75558.24441755623;76096;76869.23130768677;78774;9703.466309353053;9788.412695238309;9811.362261452983;9933.850992235122;10065.597376104874;13226.933865330611;13307.93346033283;13361.19832810015;13502.257375844227;13527.864721352857;6518.185226846645;6743.258241593421;6792.728290868409;6889.345512176335;6939.826504337331;6268.279147897959;6297.559170858088;6306.1171435998995;6394.648294343763;6477.870442591122;4098.8360465581045;4116.115035267372;4129.442525259112;4148;4150.771707556113;1606.7589861520864;1627.5117464760524;1658.5936445570912;1669.4741156535651;1686.8481836634517;813.7477382011596;817.9222973817477;818.5538881309582;837.4807619276088;840.6301227459898;16098.839011609734;16233.756493652605;16252.18739063042;16456.83543164577;16600.252988615543;824.3322908444179;825.5624519004937;826.1449399871104;830.7134038756619;857.3398483167925;9157.450552966844;9234.630614775333;9516.707185506668;9537.523123843781;9540.952295238618;467731;482467;482486;483080;493292;85033.57483212545;86740.56629716812;86879.56560217158;87374.56312718395;87742;883.8895138107737;890.3233542507741;922.276013329533;928.6703220356676;928.9071092890657;14440.927795360956;14642.780358294422;14654;14952.700945980801;15002.774958375414;35015.47476787901;36529.452058218616;38057;38111.61888381081;41916;51151;52668.473315266354;53280.733596333324;53359.466405337;54713.72643136759;7124;7253.238409966877;7429.777106686808;7461.888071678821;7507.324340809353;10795.29830561011;11088.722781930517;11462.484188211718;11698.824517632413;11935.701607459536;9883.834220190305;9937.10566049059;10000.849987250343;10152.441615710912;10375.688729338131;9794.559244833858;9886.209103271865;10152.543135559064;10185.287029907835;10411.063004329646;10038.196944244297;10074.244431667508;10243.92438793916;10287.794244115226;10556;6596.70314835824;6758.391744742997;6836.111305530249;7813.101493328113;7863.803404914923;9181.54092295396;9199.954000229956;9245.537723113683;9825.312228143961;9836.016398360107 19:32:16 INFO - PROCESS | 10138 | |3;mootools.html;1257.1891130221009;1282.102528230239;1295.3976400973545;1296.0927350854402;1298.7077907470825;5752.367239603651;5993.550483713728;6128.693565321732;6474.449671777898;6508.28408875024;6105.145279660851;6293.056041593763;6296.464800491964;6325.082862984865;6451.451626611732;1970.1725275384338;2031.8476114291414;2035.4911272181955;2043.7956204379518;2048.4366799130207;1769.752234687145;1827.3056238629301;1975.0914579293542;1994.8304394126517;2002.8898410587412;1929.0740444586606;1989.7711763147206;2000.3398878370176;2002.1190676102542;2003.3989803059023;1981.3362523554626;1992.7409436773198;2004.8897310647908;2012.7383440152832;2019.717239586459;2032.756069271682;2058.639738045851;2059.166037754712;2060.5157787919825;2061.5361543652707;6399.712012959428;6416.582922110048;6436.581622194542;6508.93491065088;6569.178852643419;3879.1659793144327;3963.2469830732357;3974.1455587048636;3978.204359128186;3998.200359928026;2566.8588227647474;2747.0248061938123;2747.3818390862098;2750.8349499030123;2752.2018614601743;1015.5582321690015;1094.3488624268628;1119.0040863631375;1140.6863112644007;1153.4175241503071;8023.077346105214;8117.675292988273;8149.755507334789;8167.550784706898;8172.060213075513;3458.515807786912;3523.5771707395274;3551.1654761131113;3608.278344331144;3619.366610843092;7261.2012678605315;7265.673044713;7282.890756638654;7318.817029574197;7322.560646361236;3901.044244160142;3936.3308237599676;3953.802309884494;4020.155767288902;4022.959770402317;3698.3527882620433;3746.351605293662;3750.7562008469363;3758.098056466483;3758.342290099222;3180.507021411685;3223.7904536205074;3236.4336241157703;3266.836658167082;3324.3018966017407;953.227885412804;964.3490643815396;1029.8249297619423;1069.7486090768664;1080.2114456446839;749.726349882289;767.458941446279;771.864923638361;781.2148790465545;784.3764207454973;4274.593913578267;4293.527711951683;4335.826566937287;4351.630111440563;4363;885.9778505537413;908.1554154636119;920.9263258939269;921.1433366968784;929.9860502092474;2854.372038151603;2878.510653188963;2885;2907.200519857014;2917.3290143266745;7166.104236970379;7320.084989376328;7373.594452305175;7388.926110738824;7406.259374062551;7010.439164866799;7315.158756743042;7368.778936631909;7423.554586724814;7525.661345239478;6020.157177995085;6153.969230153821;6161.106639537242;6162.3053660242895;6166.136740856284;4357.477102747691;4465.151621191963;4490.506044335055;4604.355390245435;4715.26913328421;6887.5178737487895;6979.232284448808;7034.542754721131;7089.326513981164;7102.644867756489;6776.457883369417;6930.896036559355;6933.861322773415;7094.396976257076;7181.389581885598;5687.20379146928;5724.713764311685;5747.827565173052;5762.625429347079;5792.594518383673;6024.367441418588;6102.6643534604245;6126.417990290915;6168.074788781719;6176.413240742122;4948.1835497142565;5421.349438067457;5514.531264842533;5514.889702206014;5542.889142217214;5309.283246761638;5383.838484845461;5399.190121481652;5404.702741349263;5460.781568737206;4967.627427942846;4985.925211121764;5002.724850133278;5014.498550144956;5014.674046186986;3830.4445855351373;3938.15329704115;4014.6587540058254;4019.4171845082883;4048.0689441429226;3946.921061578695;3976;4033.1530378619645;4078.347464405681;4116.073883376336 19:32:16 INFO - PROCESS | 10138 | |4;prototype.html;304.21360782377553;314.6507376811737;315.9178613560474;319.88324261644493;323.8299892556409;4886.486918873516;4988.925166122511;5006.599472042237;5047;5054.166062599676;4922.655414121004;4949.876253093666;4960.156773348531;4996.102260688801;5025.974870125653;3715.6841668458214;3846.211526637033;3855.8817942796554;3859.112404147055;3874.1089549403514;3854.3062248795204;3860.942085868714;3865.3042452358704;3869.8645547405845;3872.2255548890334;3773.6415040571237;3818.77087374757;3823.120682243086;3833.252515759428;3851.5350175887456;3833.4824798652103;3854.8458061677497;3858.575556688762;3861.9806900965455;3877.2827027000094;3249.610046794376;3317.800931944091;3327.3678001179696;3337.7997320160866;3353.8826141085187;4858.246971719389;4866.440359358684;4880.633952453544;4882.365292511986;4887.3402090717655;4343.67422443318;4353.717008394444;4356.8257269709175;4363.6072753452345;4371;4986.202207646796;5172.922406163911;5233.162693968985;5238.79044838206;5255.553277971377;3610.1046950351015;3616.258666973264;3627.111357717376;3630.4009838376637;3646.8541258349633;5438.621909362962;5447.264619276387;5470.56235501159;5479.972600136974;5481.68276771531;3576.409892367782;3658.7438879278193;3696.2053158571034;3711.31340701971;3720.032791474236;3669.9633003669624;3690.55713314404;3708.7033037356946;3730.2539492101687;3756.0985363513105;4354.259775838115;4365.170617582649;4366.19225443294;4372.300431930876;4383.189110014658;5259.184826351921;5282.2340760589495;5297.284866543045;5337.733113344395;5341.332333458317;1203.4163430736087;1250.7373451575272;1257.8427995986926;1263.5072321794507;1269.8666640002853;816.7095988338411;841.2680967558264;852.8699473198037;857.7684025313131;861.5261606116611;4470;4471.552844715502;4485;4501;4607.493175750665;5386.946130538723;5391.245225668409;5394;5396.7571459283645;5418.91871621926;4631.189541830234;4635.096156249567;4636.400441847557;4658.417697787777;4664.137134630037;2735.8221715588425;2810.1990932584117;2832.4618322518654;2833.70246124154;2834.4331133772916;4944.431390390079;4949.208126699711;4953.405591329064;4960.851174464772;4988.6507944444265;5374.608299306771;5380.569554435636;5388;5402.108652072443;5414.810481633124;4733.692309999839;4835.395575552985;4870.220764677776;4886.21820508724;4921.981987385155;5174.120399532164;5180.197069454241;5184.263271803988;5194.428612852659;5267.57859371257;5181.844544663666;5201.92197117036;5230.450802665665;5232.534890230741;5246.868828279324;4649.488556258876;4809.278608208797;4835.395575553056;4907.803687852446;4936.210206367107;3840.2895464339185;3873.5351757788117;3882.2141814765523;3888.902777430587;3894.727369084137;5224.686518808883;5268.4731526848545;5283.656562323436;5311.892542862469;5320.228566857862;4947.777350019186;5039.622028347815;5117.641765076409;5156;5183.637145399936;5102.923456148086;5109.821156259513;5113.335266415343;5114.343244580143;5134.922976155286;5040.521150490697;5060.316857224375;5077.238414237894;5077.543021128116;5078.568321692697;4895.290182923527;5101.413337466239;5167.088177374396;5179.507946745053;5195.350581177353;5137.998090372342;5161.967606478795;5170.870728231825;5178.974105129601;5180.7409629519125 19:32:16 INFO - PROCESS | 10138 | |5;yui.html;649.9382558656926;663.2174034639127;732.194585955449;777.4907435629661;784.8665726826441;11669.474873630686;12574.497020119206;12636.620901372973;12654.304013279267;12661.746765064705;12331.013518918488;12395.628131156058;12419.441125149368;12439.067069969744;12446.937765311184;650.3756393861898;666.823291827666;742.2354974376401;783.1502819440914;801.1027649033091;804.6218277409637;806.4717609965483;807.1968391450515;809.0857331215718;809.2595275323073;845.1168528887328;845.446232717571;847.7033038436529;848.101012926297;848.3298194426395;833.3832963606948;836.640244694781;840.3235395506615;843.2832092721169;843.6119385082839;616.771794436057;618.1716499890124;622.2066864747438;623.2085251730277;623.9126522286883;12976;13219.405126769318;13282.003849711311;13284.070115091947;13343.799843002364;11558;11624.94187529057;11705.239159454693;11989.460474278678;13093;11998.58004969822;12028;12067.517299308018;12092.093093017971;12833.294168820712;4169.217674376942;4179.749215047107;4209.2423363794505;4243.511996120455;4377.562243775629;68160.65919670419;68181;68757.3124268756;68947.3105268946;70302.64848675724;10073.949630251802;10209.540570674337;10225.642102526375;10314;10376.066154046172;18030.63938721218;18189.909050454662;18225.270989160552;18286.268549258148;18298.542536436697;6426.260979987268;6460.289368169498;6474.255460622088;6764.83087922796;6778.93221067783;3543.9645603543636;3604.1786132788466;3638;3663.139162296858;3681.1533347330264;2786.0527420677067;2821.3369858083333;2842.019503271368;2842.204182828811;2847.757940575033;483.8040593559614;485.32782096796194;488.36756400461485;492.5468568916605;496.5927939089984;593.4451288045691;594.6669864875597;604.4952464691944;616.1774031667684;636.4894247875055;8081.393895457747;8165.63254653542;8214.699884032361;8416.78958026042;8660.220580147818;579.7709904587664;582.9303228575527;589.7611467355728;592.520058752412;619.6963487890991;4000.5599384067727;4086.8160932758096;4123.092919557693;4148.481439820022;4263.424437700933;66654.33345666579;67078.3292167072;67287;67346;67378.66310668514;46202;47097.76451117722;56612.15081773777;60378.69810650919;61062.69468652628;53593.73203133959;54255.186172207446;55467.72266138643;56040;56604;7651.273129052731;7895.605219738875;8029.357651387992;8060.071094779876;8180.30467410253;37165.62834371622;37536.812315938245;38065.61934380621;39026.804865975486;39351;38889;40114.1977160461;45180;48565.900580438545;49718.50281497139;10978.945105274423;10995.34027958325;11031.503582338653;11240.662780116609;11440.542378304775;12466.252024878537;13451.621405234617;13760.243186624832;14041.015439518824;14671;11899.524019039487;12041.33772642513;12272;12555;12599;12765.553205637758;12906.354682266037;12980.935095324463;13065.608031759062;13406.865931340562;11234.382108984084;11711.121665874924;12236.938815305866;12259.570915017932;12303.077269205025;10136.645217417356;10353.4305613192;10696.144308455461;10984.484964811503;11145;9344.439333640003;9972.202223822222;10324;10457.9477102614;10463.581456741646 19:32:16 INFO - PROCESS | 10138 | __end_tp_report 19:32:16 INFO - PROCESS | 10138 | __start_cc_report 19:32:16 INFO - PROCESS | 10138 | _x_x_mozilla_cycle_collect,327 19:32:16 INFO - PROCESS | 10138 | __end_cc_report 19:32:16 INFO - PROCESS | 10138 | __startTimestamp1484019136164__endTimestamp 19:32:16 INFO - PROCESS | 10138 | 19:32:16 INFO - PROCESS | 10138 | ------- Summary: start ------- 19:32:16 INFO - PROCESS | 10138 | Number of tests: 6 19:32:16 INFO - PROCESS | 10138 | 19:32:16 INFO - PROCESS | 10138 | [#0] dojo.html Cycles:165 Average:4705.73 Median:4825.30 stddev:497.08 (10.3%) stddev-sans-first:470.01 19:32:16 INFO - PROCESS | 10138 | Values: 2587.4 2588.7 2589.2 2613.2 2621.3 4672.4 4721.6 4731.4 4747.2 4760.7 4703.7 4735.5 4754.2 4776.3 4790.4 4323.1 4351.9 4398.1 4430.7 4467.4 4396.2 4436.4 4493.2 4510.4 4532.9 4323.8 4333.8 4369.1 4401.8 4437.4 4344.8 4375.6 4391.7 4409.6 4425.8 4328.2 4329.1 4352.3 4372.3 4409.4 4633.5 4665.7 4677.2 4721.5 4735.7 4995.9 5063.3 5082.9 5108.3 5135.7 5106.1 5109.4 5113.1 5125.9 5130.5 4786.3 4787.5 4800.4 4825.2 4825.3 5117.6 5165.7 5170.1 5177.1 5199.9 5001.0 5023.4 5024.1 5036.4 5038.8 4958.7 5092.4 5113.6 5116.3 5125.4 4988.8 4991.8 5019.3 5039.7 5088.4 5044.7 5051.7 5056.5 5063.7 5095.2 4311.9 4335.6 4340.0 4343.6 4386.0 3721.2 3730.1 3740.3 3749.6 3812.6 4387.9 4388.8 4397.1 4426.1 4429.2 5122.3 5126.5 5130.7 5134.2 5139.2 4337.3 4351.8 4388.6 4388.6 4419.2 4599.1 4623.4 4628.9 4668.6 4680.2 4795.7 4796.0 4808.4 4829.8 4853.8 5061.9 5084.5 5130.1 5134.0 5138.0 4775.7 4786.4 4797.8 4828.7 4840.6 5025.2 5029.5 5034.9 5051.5 5083.6 5018.4 5072.2 5117.6 5139.1 5181.8 4917.9 4935.3 4948.0 4964.9 4985.1 4906.3 4948.8 4950.8 4956.3 5009.6 4746.7 4823.2 4836.4 4911.1 4930.9 4915.5 4963.1 4977.6 4995.2 4997.6 4879.5 4881.9 4912.7 4955.6 4972.9 19:32:16 INFO - PROCESS | 10138 | 19:32:16 INFO - PROCESS | 10138 | [#1] ext.html Cycles:180 Average:46154.99 Median:3644.12 stddev:87505.97 (2401.3%) stddev-sans-first:87684.36 19:32:16 INFO - PROCESS | 10138 | Values: 516.8 522.1 530.8 532.5 542.8 38670.4 40725.4 40765.8 44653.1 44971.6 41373.0 41856.0 41865.0 41948.9 41968.2 7785.7 7940.6 7941.2 7950.1 9654.3 9490.1 9782.4 9789.4 9810.7 9810.7 9766.6 9789.0 9823.5 9861.4 9873.3 9821.8 9837.4 9842.4 9857.8 9874.4 9710.8 9729.1 9738.0 9776.8 9786.7 34033.3 34213.8 34314.7 34361.5 34468.8 3564.2 3635.1 3643.5 3670.3 3697.7 24178.2 24210.9 24280.6 24439.3 24897.6 3433.6 3440.3 3487.8 3642.3 3644.7 239225.0 240146.0 240396.0 241337.0 242787.0 46016.1 46334.5 46336.8 46343.0 46399.5 46904.3 47017.5 47122.3 47303.3 47311.5 11895.3 12108.8 12143.3 12174.8 12192.8 8700.4 8830.1 9128.2 9294.1 9356.0 15648.0 15709.5 15802.6 15859.5 15925.6 6433.5 6460.2 6544.4 6547.0 6618.7 729.4 754.0 765.4 765.6 778.8 26547.3 27714.6 27920.4 28135.9 28268.3 863.8 906.8 912.9 913.2 922.2 13604.6 14583.7 14867.8 14965.3 15026.8 340604.0 355853.0 362488.0 364133.0 562841.0 43433.3 44042.0 44278.1 44297.0 44544.3 1208.1 1229.3 1240.5 1240.9 1247.5 25058.9 25564.5 26456.9 26540.6 26780.7 37884.8 38260.0 38316.6 38321.2 38352.4 322728.0 325114.0 325529.0 327145.0 327308.0 23230.9 23600.6 23613.8 23872.4 25527.2 36581.0 36935.8 37142.0 37239.3 37267.0 29758.0 31378.7 31894.5 32158.7 32321.5 30953.0 32183.0 32451.4 32699.8 33292.2 31334.4 32119.4 32489.0 32524.8 32545.5 28220.3 29754.6 30071.2 30274.0 30390.0 22934.0 23113.6 23238.3 23333.9 23369.0 19:32:16 INFO - PROCESS | 10138 | 19:32:16 INFO - PROCESS | 10138 | [#2] jquery.html Cycles:180 Average:27179.44 Median:5199.86 stddev:79453.06 (1528.0%) stddev-sans-first:79650.37 19:32:16 INFO - PROCESS | 10138 | Values: 330.2 339.0 341.4 354.1 361.9 17260.3 17847.4 18187.0 18393.6 18407.8 17316.6 17617.5 18036.0 18129.2 18135.7 5067.8 5222.1 5256.5 5256.9 5257.4 5056.1 5158.5 5227.5 5240.5 5246.6 5160.1 5187.1 5201.4 5216.3 5220.5 5171.6 5187.4 5199.8 5199.9 5226.9 5303.8 5413.9 5415.7 5425.6 5430.5 10757.7 10775.6 15268.3 21827.3 22002.9 1998.6 2036.9 2074.2 2101.7 2147.3 8896.7 9063.5 9072.7 9232.4 9407.6 1685.9 1744.1 1773.6 1783.9 1787.4 75114.6 75558.2 76096.0 76869.2 78774.0 9703.5 9788.4 9811.4 9933.9 10065.6 13226.9 13307.9 13361.2 13502.3 13527.9 6518.2 6743.3 6792.7 6889.3 6939.8 6268.3 6297.6 6306.1 6394.6 6477.9 4098.8 4116.1 4129.4 4148.0 4150.8 1606.8 1627.5 1658.6 1669.5 1686.8 813.7 817.9 818.6 837.5 840.6 16098.8 16233.8 16252.2 16456.8 16600.3 824.3 825.6 826.1 830.7 857.3 9157.5 9234.6 9516.7 9537.5 9541.0 467731.0 482467.0 482486.0 483080.0 493292.0 85033.6 86740.6 86879.6 87374.6 87742.0 883.9 890.3 922.3 928.7 928.9 14440.9 14642.8 14654.0 14952.7 15002.8 35015.5 36529.5 38057.0 38111.6 41916.0 51151.0 52668.5 53280.7 53359.5 54713.7 7124.0 7253.2 7429.8 7461.9 7507.3 10795.3 11088.7 11462.5 11698.8 11935.7 9883.8 9937.1 10000.8 10152.4 10375.7 9794.6 9886.2 10152.5 10185.3 10411.1 10038.2 10074.2 10243.9 10287.8 10556.0 6596.7 6758.4 6836.1 7813.1 7863.8 9181.5 9200.0 9245.5 9825.3 9836.0 19:32:16 INFO - PROCESS | 10138 | 19:32:16 INFO - PROCESS | 10138 | [#3] mootools.html Cycles:180 Average:4243.79 Median:4547.43 stddev:2166.08 (47.6%) stddev-sans-first:2160.53 19:32:16 INFO - PROCESS | 10138 | Values: 1257.2 1282.1 1295.4 1296.1 1298.7 5752.4 5993.6 6128.7 6474.4 6508.3 6105.1 6293.1 6296.5 6325.1 6451.5 1970.2 2031.8 2035.5 2043.8 2048.4 1769.8 1827.3 1975.1 1994.8 2002.9 1929.1 1989.8 2000.3 2002.1 2003.4 1981.3 1992.7 2004.9 2012.7 2019.7 2032.8 2058.6 2059.2 2060.5 2061.5 6399.7 6416.6 6436.6 6508.9 6569.2 3879.2 3963.2 3974.1 3978.2 3998.2 2566.9 2747.0 2747.4 2750.8 2752.2 1015.6 1094.3 1119.0 1140.7 1153.4 8023.1 8117.7 8149.8 8167.6 8172.1 3458.5 3523.6 3551.2 3608.3 3619.4 7261.2 7265.7 7282.9 7318.8 7322.6 3901.0 3936.3 3953.8 4020.2 4023.0 3698.4 3746.4 3750.8 3758.1 3758.3 3180.5 3223.8 3236.4 3266.8 3324.3 953.2 964.3 1029.8 1069.7 1080.2 749.7 767.5 771.9 781.2 784.4 4274.6 4293.5 4335.8 4351.6 4363.0 886.0 908.2 920.9 921.1 930.0 2854.4 2878.5 2885.0 2907.2 2917.3 7166.1 7320.1 7373.6 7388.9 7406.3 7010.4 7315.2 7368.8 7423.6 7525.7 6020.2 6154.0 6161.1 6162.3 6166.1 4357.5 4465.2 4490.5 4604.4 4715.3 6887.5 6979.2 7034.5 7089.3 7102.6 6776.5 6930.9 6933.9 7094.4 7181.4 5687.2 5724.7 5747.8 5762.6 5792.6 6024.4 6102.7 6126.4 6168.1 6176.4 4948.2 5421.3 5514.5 5514.9 5542.9 5309.3 5383.8 5399.2 5404.7 5460.8 4967.6 4985.9 5002.7 5014.5 5014.7 3830.4 3938.2 4014.7 4019.4 4048.1 3946.9 3976.0 4033.2 4078.3 4116.1 19:32:16 INFO - PROCESS | 10138 | 19:32:16 INFO - PROCESS | 10138 | [#4] prototype.html Cycles:180 Average:4281.44 Median:4886.35 stddev:1255.64 (25.7%) stddev-sans-first:1223.16 19:32:16 INFO - PROCESS | 10138 | Values: 304.2 314.7 315.9 319.9 323.8 4886.5 4988.9 5006.6 5047.0 5054.2 4922.7 4949.9 4960.2 4996.1 5026.0 3715.7 3846.2 3855.9 3859.1 3874.1 3854.3 3860.9 3865.3 3869.9 3872.2 3773.6 3818.8 3823.1 3833.3 3851.5 3833.5 3854.8 3858.6 3862.0 3877.3 3249.6 3317.8 3327.4 3337.8 3353.9 4858.2 4866.4 4880.6 4882.4 4887.3 4343.7 4353.7 4356.8 4363.6 4371.0 4986.2 5172.9 5233.2 5238.8 5255.6 3610.1 3616.3 3627.1 3630.4 3646.9 5438.6 5447.3 5470.6 5480.0 5481.7 3576.4 3658.7 3696.2 3711.3 3720.0 3670.0 3690.6 3708.7 3730.3 3756.1 4354.3 4365.2 4366.2 4372.3 4383.2 5259.2 5282.2 5297.3 5337.7 5341.3 1203.4 1250.7 1257.8 1263.5 1269.9 816.7 841.3 852.9 857.8 861.5 4470.0 4471.6 4485.0 4501.0 4607.5 5386.9 5391.2 5394.0 5396.8 5418.9 4631.2 4635.1 4636.4 4658.4 4664.1 2735.8 2810.2 2832.5 2833.7 2834.4 4944.4 4949.2 4953.4 4960.9 4988.7 5374.6 5380.6 5388.0 5402.1 5414.8 4733.7 4835.4 4870.2 4886.2 4922.0 5174.1 5180.2 5184.3 5194.4 5267.6 5181.8 5201.9 5230.5 5232.5 5246.9 4649.5 4809.3 4835.4 4907.8 4936.2 3840.3 3873.5 3882.2 3888.9 3894.7 5224.7 5268.5 5283.7 5311.9 5320.2 4947.8 5039.6 5117.6 5156.0 5183.6 5102.9 5109.8 5113.3 5114.3 5134.9 5040.5 5060.3 5077.2 5077.5 5078.6 4895.3 5101.4 5167.1 5179.5 5195.4 5138.0 5162.0 5170.9 5179.0 5180.7 19:32:16 INFO - PROCESS | 10138 | 19:32:16 INFO - PROCESS | 10138 | [#5] yui.html Cycles:180 Average:15157.66 Median:4194.50 stddev:18995.10 (452.9%) stddev-sans-first:19017.15 19:32:16 INFO - PROCESS | 10138 | Values: 649.9 663.2 732.2 777.5 784.9 11669.5 12574.5 12636.6 12654.3 12661.7 12331.0 12395.6 12419.4 12439.1 12446.9 650.4 666.8 742.2 783.2 801.1 804.6 806.5 807.2 809.1 809.3 845.1 845.4 847.7 848.1 848.3 833.4 836.6 840.3 843.3 843.6 616.8 618.2 622.2 623.2 623.9 12976.0 13219.4 13282.0 13284.1 13343.8 11558.0 11624.9 11705.2 11989.5 13093.0 11998.6 12028.0 12067.5 12092.1 12833.3 4169.2 4179.7 4209.2 4243.5 4377.6 68160.7 68181.0 68757.3 68947.3 70302.6 10073.9 10209.5 10225.6 10314.0 10376.1 18030.6 18189.9 18225.3 18286.3 18298.5 6426.3 6460.3 6474.3 6764.8 6778.9 3544.0 3604.2 3638.0 3663.1 3681.2 2786.1 2821.3 2842.0 2842.2 2847.8 483.8 485.3 488.4 492.5 496.6 593.4 594.7 604.5 616.2 636.5 8081.4 8165.6 8214.7 8416.8 8660.2 579.8 582.9 589.8 592.5 619.7 4000.6 4086.8 4123.1 4148.5 4263.4 66654.3 67078.3 67287.0 67346.0 67378.7 46202.0 47097.8 56612.2 60378.7 61062.7 53593.7 54255.2 55467.7 56040.0 56604.0 7651.3 7895.6 8029.4 8060.1 8180.3 37165.6 37536.8 38065.6 39026.8 39351.0 38889.0 40114.2 45180.0 48565.9 49718.5 10978.9 10995.3 11031.5 11240.7 11440.5 12466.3 13451.6 13760.2 14041.0 14671.0 11899.5 12041.3 12272.0 12555.0 12599.0 12765.6 12906.4 12980.9 13065.6 13406.9 11234.4 11711.1 12236.9 12259.6 12303.1 10136.6 10353.4 10696.1 10984.5 11145.0 9344.4 9972.2 10324.0 10457.9 10463.6 19:32:16 INFO - PROCESS | 10138 | -------- Summary: end -------- 19:32:16 INFO - PROCESS | 10138 | 19:32:16 INFO - TEST-INFO | 10138: exit 0 19:32:16 INFO - TEST-OK | dromaeo_css | took 1118776ms 19:32:16 INFO - TEST-START | kraken 19:32:16 INFO - operating with platform_type : linux_ 19:32:16 INFO - Initialising browser for kraken test... 19:32:16 INFO - TEST-INFO | started process 10491 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcXVdLw/profile http://localhost:54837/getInfo.html) 19:32:17 INFO - PROCESS | 10491 | 1484019137450 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4906 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3761 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2794 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 19:32:21 INFO - PROCESS | 10491 | __metrics Screen width/height:1600/1200 19:32:21 INFO - PROCESS | 10491 | colorDepth:24 19:32:21 INFO - PROCESS | 10491 | Browser inner width/height: 1024/697 19:32:21 INFO - PROCESS | 10491 | __metrics 19:32:21 ERROR - PROCESS | 10491 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 19:32:22 INFO - TEST-INFO | 10491: exit 0 19:32:22 INFO - Browser initialized. 19:32:22 INFO - Running cycle 1/1 for kraken test... 19:32:22 INFO - TEST-INFO | started process 10611 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcXVdLw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:32:34 INFO - PROCESS | 10611 | RSS: Main: 159088640 19:32:34 INFO - PROCESS | 10611 | 19:32:37 INFO - PROCESS | 10611 | Cycle 1(1): loaded http://localhost:54837/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54837/tests/kraken/driver.html?testName=audio-beat-detection) 19:32:38 INFO - PROCESS | 10611 | RSS: Main: 164974592 19:32:38 INFO - PROCESS | 10611 | 19:32:41 INFO - PROCESS | 10611 | Cycle 1(1): loaded http://localhost:54837/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54837/tests/kraken/driver.html?testName=audio-dft) 19:32:41 INFO - PROCESS | 10611 | RSS: Main: 163643392 19:32:41 INFO - PROCESS | 10611 | 19:32:44 INFO - PROCESS | 10611 | Cycle 1(1): loaded http://localhost:54837/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54837/tests/kraken/driver.html?testName=audio-fft) 19:32:45 INFO - PROCESS | 10611 | RSS: Main: 161509376 19:32:45 INFO - PROCESS | 10611 | 19:32:47 INFO - PROCESS | 10611 | Cycle 1(1): loaded http://localhost:54837/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54837/tests/kraken/driver.html?testName=audio-oscillator) 19:32:48 INFO - PROCESS | 10611 | RSS: Main: 161464320 19:32:48 INFO - PROCESS | 10611 | 19:32:50 INFO - PROCESS | 10611 | Cycle 1(1): loaded http://localhost:54837/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54837/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:32:51 INFO - PROCESS | 10611 | RSS: Main: 161763328 19:32:51 INFO - PROCESS | 10611 | 19:32:54 INFO - PROCESS | 10611 | Cycle 1(1): loaded http://localhost:54837/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54837/tests/kraken/driver.html?testName=imaging-darkroom) 19:32:54 INFO - PROCESS | 10611 | RSS: Main: 166645760 19:32:54 INFO - PROCESS | 10611 | 19:32:58 INFO - PROCESS | 10611 | Cycle 1(1): loaded http://localhost:54837/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54837/tests/kraken/driver.html?testName=imaging-desaturate) 19:32:58 INFO - PROCESS | 10611 | RSS: Main: 162684928 19:32:58 INFO - PROCESS | 10611 | 19:33:01 INFO - PROCESS | 10611 | Cycle 1(1): loaded http://localhost:54837/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54837/tests/kraken/driver.html?testName=json-parse-financial) 19:33:02 INFO - PROCESS | 10611 | RSS: Main: 164208640 19:33:02 INFO - PROCESS | 10611 | 19:33:04 INFO - PROCESS | 10611 | Cycle 1(1): loaded http://localhost:54837/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54837/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:33:04 INFO - PROCESS | 10611 | RSS: Main: 164392960 19:33:04 INFO - PROCESS | 10611 | 19:33:06 INFO - PROCESS | 10611 | Cycle 1(1): loaded http://localhost:54837/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54837/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:33:07 INFO - PROCESS | 10611 | RSS: Main: 164044800 19:33:07 INFO - PROCESS | 10611 | 19:33:09 INFO - PROCESS | 10611 | Cycle 1(1): loaded http://localhost:54837/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54837/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:33:10 INFO - PROCESS | 10611 | RSS: Main: 164466688 19:33:10 INFO - PROCESS | 10611 | 19:33:12 INFO - PROCESS | 10611 | Cycle 1(1): loaded http://localhost:54837/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54837/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:33:13 INFO - PROCESS | 10611 | RSS: Main: 164753408 19:33:13 INFO - PROCESS | 10611 | 19:33:16 INFO - PROCESS | 10611 | Cycle 1(1): loaded http://localhost:54837/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54837/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:33:17 INFO - PROCESS | 10611 | RSS: Main: 167632896 19:33:17 INFO - PROCESS | 10611 | 19:33:19 INFO - PROCESS | 10611 | Cycle 1(1): loaded http://localhost:54837/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54837/tests/kraken/driver.html?testName=ai-astar) 19:33:19 INFO - PROCESS | 10611 | RSS: Main: 168140800 19:33:19 INFO - PROCESS | 10611 | 19:33:19 INFO - PROCESS | 10611 | __start_tp_report 19:33:19 INFO - PROCESS | 10611 | _x_x_mozilla_page_load 19:33:19 INFO - PROCESS | 10611 | _x_x_mozilla_page_load_details 19:33:19 INFO - PROCESS | 10611 | |i|pagename|runs| 19:33:19 INFO - PROCESS | 10611 | |0;ai-astar;108;116;114;115;114;117;115;115;115;115 19:33:19 INFO - PROCESS | 10611 | |1;audio-beat-detection;150;126;124;160;127;126;127;126;147;126 19:33:19 INFO - PROCESS | 10611 | |2;audio-dft;167;165;166;175;166;167;166;163;162;164 19:33:19 INFO - PROCESS | 10611 | |3;audio-fft;77;77;77;113;77;76;76;75;101;77 19:33:19 INFO - PROCESS | 10611 | |4;audio-oscillator;85;84;106;84;86;85;104;84;85;102 19:33:19 INFO - PROCESS | 10611 | |5;imaging-gaussian-blur;117;117;119;119;118;117;120;117;118;118 19:33:19 INFO - PROCESS | 10611 | |6;imaging-darkroom;152;150;155;151;151;152;151;149;152;149 19:33:19 INFO - PROCESS | 10611 | |7;imaging-desaturate;96;96;98;95;96;96;96;97;96;96 19:33:19 INFO - PROCESS | 10611 | |8;json-parse-financial;66;66;65;66;68;69;72;67;66;66 19:33:19 INFO - PROCESS | 10611 | |9;json-stringify-tinderbox;67;68;68;67;68;71;68;69;68;68 19:33:19 INFO - PROCESS | 10611 | |10;stanford-crypto-aes;86;86;86;85;90;85;91;84;87;85 19:33:19 INFO - PROCESS | 10611 | |11;stanford-crypto-ccm;144;145;136;147;138;133;132;133;190;148 19:33:19 INFO - PROCESS | 10611 | |12;stanford-crypto-pbkdf2;179;179;178;181;179;179;185;182;179;182 19:33:19 INFO - PROCESS | 10611 | |13;stanford-crypto-sha256-iterative;76;69;78;72;68;70;70;72;71;72 19:33:19 INFO - PROCESS | 10611 | __end_tp_report 19:33:19 INFO - PROCESS | 10611 | __start_cc_report 19:33:19 INFO - PROCESS | 10611 | _x_x_mozilla_cycle_collect,812 19:33:19 INFO - PROCESS | 10611 | __end_cc_report 19:33:19 INFO - PROCESS | 10611 | __startTimestamp1484019199505__endTimestamp 19:33:19 INFO - PROCESS | 10611 | 19:33:19 INFO - PROCESS | 10611 | ------- Summary: start ------- 19:33:19 INFO - PROCESS | 10611 | Number of tests: 14 19:33:19 INFO - PROCESS | 10611 | 19:33:19 INFO - PROCESS | 10611 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.00 stddev:2.41 (2.1%) stddev-sans-first:0.93 19:33:19 INFO - PROCESS | 10611 | Values: 108.0 116.0 114.0 115.0 114.0 117.0 115.0 115.0 115.0 115.0 19:33:19 INFO - PROCESS | 10611 | 19:33:19 INFO - PROCESS | 10611 | [#1] audio-beat-detection Cycles:10 Average:133.90 Median:127.00 stddev:13.14 (10.3%) stddev-sans-first:12.58 19:33:19 INFO - PROCESS | 10611 | Values: 150.0 126.0 124.0 160.0 127.0 126.0 127.0 126.0 147.0 126.0 19:33:19 INFO - PROCESS | 10611 | 19:33:19 INFO - PROCESS | 10611 | [#2] audio-dft Cycles:10 Average:166.10 Median:166.00 stddev:3.54 (2.1%) stddev-sans-first:3.74 19:33:19 INFO - PROCESS | 10611 | Values: 167.0 165.0 166.0 175.0 166.0 167.0 166.0 163.0 162.0 164.0 19:33:19 INFO - PROCESS | 10611 | 19:33:19 INFO - PROCESS | 10611 | [#3] audio-fft Cycles:10 Average:82.60 Median:77.00 stddev:13.18 (17.1%) stddev-sans-first:13.83 19:33:19 INFO - PROCESS | 10611 | Values: 77.0 77.0 77.0 113.0 77.0 76.0 76.0 75.0 101.0 77.0 19:33:19 INFO - PROCESS | 10611 | 19:33:19 INFO - PROCESS | 10611 | [#4] audio-oscillator Cycles:10 Average:90.50 Median:84.50 stddev:9.38 (11.1%) stddev-sans-first:9.74 19:33:19 INFO - PROCESS | 10611 | Values: 85.0 84.0 106.0 84.0 86.0 85.0 104.0 84.0 85.0 102.0 19:33:19 INFO - PROCESS | 10611 | 19:33:19 INFO - PROCESS | 10611 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.05 (0.9%) stddev-sans-first:1.05 19:33:19 INFO - PROCESS | 10611 | Values: 117.0 117.0 119.0 119.0 118.0 117.0 120.0 117.0 118.0 118.0 19:33:19 INFO - PROCESS | 10611 | 19:33:19 INFO - PROCESS | 10611 | [#6] imaging-darkroom Cycles:10 Average:151.20 Median:151.50 stddev:1.75 (1.2%) stddev-sans-first:1.83 19:33:19 INFO - PROCESS | 10611 | Values: 152.0 150.0 155.0 151.0 151.0 152.0 151.0 149.0 152.0 149.0 19:33:19 INFO - PROCESS | 10611 | 19:33:19 INFO - PROCESS | 10611 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 19:33:19 INFO - PROCESS | 10611 | Values: 96.0 96.0 98.0 95.0 96.0 96.0 96.0 97.0 96.0 96.0 19:33:19 INFO - PROCESS | 10611 | 19:33:19 INFO - PROCESS | 10611 | [#8] json-parse-financial Cycles:10 Average:67.10 Median:66.50 stddev:2.08 (3.1%) stddev-sans-first:2.17 19:33:19 INFO - PROCESS | 10611 | Values: 66.0 66.0 65.0 66.0 68.0 69.0 72.0 67.0 66.0 66.0 19:33:19 INFO - PROCESS | 10611 | 19:33:19 INFO - PROCESS | 10611 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:1.14 (1.7%) stddev-sans-first:1.12 19:33:19 INFO - PROCESS | 10611 | Values: 67.0 68.0 68.0 67.0 68.0 71.0 68.0 69.0 68.0 68.0 19:33:19 INFO - PROCESS | 10611 | 19:33:19 INFO - PROCESS | 10611 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.00 stddev:2.27 (2.6%) stddev-sans-first:2.40 19:33:19 INFO - PROCESS | 10611 | Values: 86.0 86.0 86.0 85.0 90.0 85.0 91.0 84.0 87.0 85.0 19:33:19 INFO - PROCESS | 10611 | 19:33:19 INFO - PROCESS | 10611 | [#11] stanford-crypto-ccm Cycles:10 Average:144.60 Median:144.50 stddev:17.08 (11.8%) stddev-sans-first:18.11 19:33:19 INFO - PROCESS | 10611 | Values: 144.0 145.0 136.0 147.0 138.0 133.0 132.0 133.0 190.0 148.0 19:33:19 INFO - PROCESS | 10611 | 19:33:19 INFO - PROCESS | 10611 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.30 Median:180.00 stddev:2.16 (1.2%) stddev-sans-first:2.24 19:33:19 INFO - PROCESS | 10611 | Values: 179.0 179.0 178.0 181.0 179.0 179.0 185.0 182.0 179.0 182.0 19:33:19 INFO - PROCESS | 10611 | 19:33:19 INFO - PROCESS | 10611 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:72.00 stddev:3.08 (4.3%) stddev-sans-first:2.87 19:33:19 INFO - PROCESS | 10611 | Values: 76.0 69.0 78.0 72.0 68.0 70.0 70.0 72.0 71.0 72.0 19:33:19 INFO - PROCESS | 10611 | -------- Summary: end -------- 19:33:19 INFO - PROCESS | 10611 | 19:33:20 INFO - TEST-INFO | 10611: exit 0 19:33:20 INFO - TEST-OK | kraken | took 63597ms 19:33:20 INFO - SUITE-END | took 1182s 19:33:20 INFO - Completed test suite (00:19:42) 19:33:20 INFO - javascript benchmark 19:33:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6196.091997115828, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2587.391962888721, 2588.7022992355874, 2589.1585234798695, 2613.2160351894427, 2621.2660455072587, 4672.439307283131, 4721.645876559259, 4731.43222813262, 4747.240441529351, 4760.738159401231, 4703.670743047979, 4735.50277220892, 4754.239321708527, 4776.331313616097, 4790.401199850019, 4323.135372925428, 4351.934720979196, 4398.098389830093, 4430.712003719748, 4467.352233926079, 4396.186705459484, 4436.378906953013, 4493.191225579394, 4510.368548403226, 4532.864014079566, 4323.789338985089, 4333.848315308981, 4369.060651959844, 4401.779911004437, 4437.356583295404, 4344.782760861945, 4375.606195442426, 4391.692581519295, 4409.559044095565, 4425.7565833879125, 4328.2209202343565, 4329.06925011121, 4352.303631418989, 4372.322290045016, 4409.4488188976375, 4633.49031606523, 4665.720056796603, 4677.204875171229, 4721.457032441244, 4735.73953432561, 4995.9250611240495, 5063.316452278932, 5082.949170508285, 5108.3359163308905, 5135.666181698178, 5106.106431374495, 5109.386873575195, 5113.130767769451, 5125.9257779531, 5130.53825155734, 4786.282057691375, 4787.54518320759, 4800.4479484859685, 4825.20384136617, 4825.30033145192, 5117.590592752571, 5165.66423182492, 5170.1469257572835, 5177.145770947752, 5199.856031673025, 5001.049800537886, 5023.372078490189, 5024.145895197825, 5036.420811606712, 5038.823641172541, 4958.652894297436, 5092.414372347227, 5113.64204505681, 5116.334876466036, 5125.410577783528, 4988.775505102279, 4991.800327986913, 5019.347484826949, 5039.722815245197, 5088.414832294259, 5044.672096313728, 5051.722155281422, 5056.469070747592, 5063.696178229245, 5095.15929871567, 4311.8706438806885, 4335.609795118455, 4339.956600433955, 4343.5656434356315, 4385.956140438619, 3721.1813401051727, 3730.1420673245307, 3740.2893450244364, 3749.6250374962287, 3812.5996770338716, 4387.890302742393, 4388.780560972003, 4397.0546332538015, 4426.070525189746, 4429.224885645063, 5122.257272695439, 5126.4617215191865, 5130.717810520383, 5134.204198349262, 5139.152039913372, 4337.306031035019, 4351.760653164043, 4388.605025547716, 4388.626966707801, 4419.248727716296, 4599.126166028444, 4623.375844261049, 4628.907421851612, 4668.626509879202, 4680.157571637138, 4795.736234507136, 4796.040791841576, 4808.3989501312335, 4829.782659780319, 4853.757312134449, 5061.9493805061475, 5084.491550844886, 5130.050940576006, 5133.998870220271, 5137.974310128575, 4775.689580177277, 4786.44955830084, 4797.832075877328, 4828.734419606955, 4840.6127509798425, 5025.170846810235, 5029.497050294941, 5034.899302013866, 5051.520105589963, 5083.593312534915, 5018.372703412074, 5072.213806859942, 5117.641765076409, 5139.126348520836, 5181.766820493162, 4917.852464426073, 4935.259711043373, 4948.035133149146, 4964.851054468371, 4985.052839960396, 4906.313116163668, 4948.837023299594, 4950.801967921243, 4956.330895329229, 5009.574186194069, 4746.691465054761, 4823.2282834747675, 4836.395450568679, 4911.066897289504, 4930.852074437773, 4915.483874193301, 4963.10664080469, 4977.552020318189, 4995.150824359795, 4997.625178111583, 4879.487653796442, 4881.9023619528125, 4912.680675756064, 4955.628327875496, 4972.900541989212], "value": 4673.06768587626, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [516.8397796683029, 522.0889547739196, 530.7744208711297, 532.5473347654494, 542.7557599080415, 38670.419943700865, 40725.3891191632, 40765.79617101914, 44653.10693786122, 44971.55028449715, 41373.0, 41856.0, 41865.0, 41948.91740697597, 41968.160636787245, 7785.688572457095, 7940.602969851513, 7941.20587941207, 7950.0857401399, 9654.324197306192, 9490.145886870181, 9782.413055216673, 9789.412635241873, 9810.656627018056, 9810.705678829647, 9766.609335626603, 9788.95105524475, 9823.50882455878, 9861.359011664255, 9873.259505537078, 9821.803563928717, 9837.360571562825, 9842.409455432697, 9857.753556161153, 9874.407535547818, 9710.805783884354, 9729.075737804897, 9737.951310243474, 9776.755581110458, 9786.657466988692, 34033.31933361319, 34213.82893085544, 34314.6568534314, 34361.48457773135, 34468.82765586181, 3564.198055437532, 3635.0912271932016, 3643.544556930384, 3670.284294562561, 3697.6856967157555, 24178.153764618153, 24210.878945605335, 24280.63579046316, 24439.26682199537, 24897.62653560198, 3433.6051354094348, 3440.3291358185165, 3487.7907325560545, 3642.253338065717, 3644.6902013328636, 239225.0, 240146.0, 240396.0, 241337.0, 242787.0, 46016.07967840692, 46334.536654633695, 46336.7683161582, 46343.0, 46399.53600463952, 46904.29643555349, 47017.529824702, 47122.29316560255, 47303.29045064327, 47311.5268847314, 11895.286282823059, 12108.81836772449, 12143.332116733665, 12174.756504869853, 12192.756144877052, 8700.390972631854, 8830.116988301119, 9128.178463938277, 9294.117058879396, 9355.95322023399, 15648.0, 15709.507596778289, 15802.60493487649, 15859.52421427359, 15925.601859953595, 6433.485321174295, 6460.192475940507, 6544.3782840630065, 6546.967265163644, 6618.735250590019, 729.4237552333703, 754.0498971296097, 765.3991616580957, 765.6324964017302, 778.7507997440764, 26547.336316591853, 27714.5842812358, 27920.441591168063, 28135.859320703676, 28268.293292667848, 863.77061102124, 906.8301890561235, 912.926965842731, 913.182701482183, 922.2437601166979, 13604.606449228655, 14583.718663300673, 14867.776983345258, 14965.251737413086, 15026.774598381033, 340604.0, 355853.0, 362488.0, 364133.0, 562841.0, 43433.34849977253, 44042.0, 44278.11443771107, 44297.0, 44544.3318350225, 1208.0939295528353, 1229.305442425045, 1240.5347994502063, 1240.8697086805937, 1247.5134697467995, 25058.874705626356, 25564.48871022532, 26456.86771566207, 26540.601890972037, 26780.732192677824, 37884.81057594695, 38260.0, 38316.61683383242, 38321.23357532778, 38352.42471362876, 322728.0, 325114.0, 325529.0, 327145.0, 327308.0, 23230.883845580665, 23600.645990309815, 23613.812135361506, 23872.403189919696, 25527.234182974542, 36581.0, 36935.815320923226, 37142.0, 37239.255214895005, 37267.0, 29758.0, 31378.686213137575, 31894.52158217582, 32158.678413216505, 32321.51517727189, 30953.0, 32183.0, 32451.35097298088, 32699.836500817342, 33292.16769580683, 31334.373312534077, 32119.357612847143, 32489.0, 32524.83737581297, 32545.511817322287, 28220.294492637848, 29754.553681695226, 30071.248218794706, 30274.0, 30390.0, 22934.0, 23113.5928241533, 23238.3028509145, 23333.883330583918, 23369.0], "value": 16945.648547506178, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.16303670196044, 338.95932488101425, 341.4093618040789, 354.061736398544, 361.88419705694173, 17260.309587616495, 17847.375341863037, 18187.0, 18393.63212735748, 18407.815921840778, 17316.567085822862, 17617.471475855746, 18036.0, 18129.184186711598, 18135.72796408055, 5067.771950262247, 5222.086134926391, 5256.526912577867, 5256.9474305256845, 5257.447967963366, 5056.115179843531, 5158.458361871987, 5227.503387178231, 5240.502152295526, 5246.606504512158, 5160.122779127539, 5187.144121220013, 5201.375834899817, 5216.295800067, 5220.504052115043, 5171.5862730981435, 5187.3775146982225, 5199.818006369778, 5199.896002079956, 5226.947730522722, 5303.814366497154, 5413.864653383657, 5415.675059496442, 5425.565954723652, 5430.484104010113, 10757.731056723565, 10775.5689772409, 15268.25171469135, 21827.345179644635, 22002.88998554997, 1998.5902889907534, 2036.857419980587, 2074.159965214076, 2101.684747287904, 2147.3450597567735, 8896.733098007071, 9063.546822658907, 9072.682456114071, 9232.353735238536, 9407.576659050359, 1685.9494215173565, 1744.1105036431384, 1773.5743421578857, 1783.9018853963028, 1787.3833527433014, 75114.62442687806, 75558.24441755623, 76096.0, 76869.23130768677, 78774.0, 9703.466309353053, 9788.412695238309, 9811.362261452983, 9933.850992235122, 10065.597376104874, 13226.933865330611, 13307.93346033283, 13361.19832810015, 13502.257375844227, 13527.864721352857, 6518.185226846645, 6743.258241593421, 6792.728290868409, 6889.345512176335, 6939.826504337331, 6268.279147897959, 6297.559170858088, 6306.1171435998995, 6394.648294343763, 6477.870442591122, 4098.8360465581045, 4116.115035267372, 4129.442525259112, 4148.0, 4150.771707556113, 1606.7589861520864, 1627.5117464760524, 1658.5936445570912, 1669.4741156535651, 1686.8481836634517, 813.7477382011596, 817.9222973817477, 818.5538881309582, 837.4807619276088, 840.6301227459898, 16098.839011609734, 16233.756493652605, 16252.18739063042, 16456.83543164577, 16600.252988615543, 824.3322908444179, 825.5624519004937, 826.1449399871104, 830.7134038756619, 857.3398483167925, 9157.450552966844, 9234.630614775333, 9516.707185506668, 9537.523123843781, 9540.952295238618, 467731.0, 482467.0, 482486.0, 483080.0, 493292.0, 85033.57483212545, 86740.56629716812, 86879.56560217158, 87374.56312718395, 87742.0, 883.8895138107737, 890.3233542507741, 922.276013329533, 928.6703220356676, 928.9071092890657, 14440.927795360956, 14642.780358294422, 14654.0, 14952.700945980801, 15002.774958375414, 35015.47476787901, 36529.452058218616, 38057.0, 38111.61888381081, 41916.0, 51151.0, 52668.473315266354, 53280.733596333324, 53359.466405337, 54713.72643136759, 7124.0, 7253.238409966877, 7429.777106686808, 7461.888071678821, 7507.324340809353, 10795.29830561011, 11088.722781930517, 11462.484188211718, 11698.824517632413, 11935.701607459536, 9883.834220190305, 9937.10566049059, 10000.849987250343, 10152.441615710912, 10375.688729338131, 9794.559244833858, 9886.209103271865, 10152.543135559064, 10185.287029907835, 10411.063004329646, 10038.196944244297, 10074.244431667508, 10243.92438793916, 10287.794244115226, 10556.0, 6596.70314835824, 6758.391744742997, 6836.111305530249, 7813.101493328113, 7863.803404914923, 9181.54092295396, 9199.954000229956, 9245.537723113683, 9825.312228143961, 9836.016398360107], "value": 8092.835024368668, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1257.1891130221009, 1282.102528230239, 1295.3976400973545, 1296.0927350854402, 1298.7077907470825, 5752.367239603651, 5993.550483713728, 6128.693565321732, 6474.449671777898, 6508.28408875024, 6105.145279660851, 6293.056041593763, 6296.464800491964, 6325.082862984865, 6451.451626611732, 1970.1725275384338, 2031.8476114291414, 2035.4911272181955, 2043.7956204379518, 2048.4366799130207, 1769.752234687145, 1827.3056238629301, 1975.0914579293542, 1994.8304394126517, 2002.8898410587412, 1929.0740444586606, 1989.7711763147206, 2000.3398878370176, 2002.1190676102542, 2003.3989803059023, 1981.3362523554626, 1992.7409436773198, 2004.8897310647908, 2012.7383440152832, 2019.717239586459, 2032.756069271682, 2058.639738045851, 2059.166037754712, 2060.5157787919825, 2061.5361543652707, 6399.712012959428, 6416.582922110048, 6436.581622194542, 6508.93491065088, 6569.178852643419, 3879.1659793144327, 3963.2469830732357, 3974.1455587048636, 3978.204359128186, 3998.200359928026, 2566.8588227647474, 2747.0248061938123, 2747.3818390862098, 2750.8349499030123, 2752.2018614601743, 1015.5582321690015, 1094.3488624268628, 1119.0040863631375, 1140.6863112644007, 1153.4175241503071, 8023.077346105214, 8117.675292988273, 8149.755507334789, 8167.550784706898, 8172.060213075513, 3458.515807786912, 3523.5771707395274, 3551.1654761131113, 3608.278344331144, 3619.366610843092, 7261.2012678605315, 7265.673044713, 7282.890756638654, 7318.817029574197, 7322.560646361236, 3901.044244160142, 3936.3308237599676, 3953.802309884494, 4020.155767288902, 4022.959770402317, 3698.3527882620433, 3746.351605293662, 3750.7562008469363, 3758.098056466483, 3758.342290099222, 3180.507021411685, 3223.7904536205074, 3236.4336241157703, 3266.836658167082, 3324.3018966017407, 953.227885412804, 964.3490643815396, 1029.8249297619423, 1069.7486090768664, 1080.2114456446839, 749.726349882289, 767.458941446279, 771.864923638361, 781.2148790465545, 784.3764207454973, 4274.593913578267, 4293.527711951683, 4335.826566937287, 4351.630111440563, 4363.0, 885.9778505537413, 908.1554154636119, 920.9263258939269, 921.1433366968784, 929.9860502092474, 2854.372038151603, 2878.510653188963, 2885.0, 2907.200519857014, 2917.3290143266745, 7166.104236970379, 7320.084989376328, 7373.594452305175, 7388.926110738824, 7406.259374062551, 7010.439164866799, 7315.158756743042, 7368.778936631909, 7423.554586724814, 7525.661345239478, 6020.157177995085, 6153.969230153821, 6161.106639537242, 6162.3053660242895, 6166.136740856284, 4357.477102747691, 4465.151621191963, 4490.506044335055, 4604.355390245435, 4715.26913328421, 6887.5178737487895, 6979.232284448808, 7034.542754721131, 7089.326513981164, 7102.644867756489, 6776.457883369417, 6930.896036559355, 6933.861322773415, 7094.396976257076, 7181.389581885598, 5687.20379146928, 5724.713764311685, 5747.827565173052, 5762.625429347079, 5792.594518383673, 6024.367441418588, 6102.6643534604245, 6126.417990290915, 6168.074788781719, 6176.413240742122, 4948.1835497142565, 5421.349438067457, 5514.531264842533, 5514.889702206014, 5542.889142217214, 5309.283246761638, 5383.838484845461, 5399.190121481652, 5404.702741349263, 5460.781568737206, 4967.627427942846, 4985.925211121764, 5002.724850133278, 5014.498550144956, 5014.674046186986, 3830.4445855351373, 3938.15329704115, 4014.6587540058254, 4019.4171845082883, 4048.0689441429226, 3946.921061578695, 3976.0, 4033.1530378619645, 4078.347464405681, 4116.073883376336], "value": 3552.5729818395557, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.21360782377553, 314.6507376811737, 315.9178613560474, 319.88324261644493, 323.8299892556409, 4886.486918873516, 4988.925166122511, 5006.599472042237, 5047.0, 5054.166062599676, 4922.655414121004, 4949.876253093666, 4960.156773348531, 4996.102260688801, 5025.974870125653, 3715.6841668458214, 3846.211526637033, 3855.8817942796554, 3859.112404147055, 3874.1089549403514, 3854.3062248795204, 3860.942085868714, 3865.3042452358704, 3869.8645547405845, 3872.2255548890334, 3773.6415040571237, 3818.77087374757, 3823.120682243086, 3833.252515759428, 3851.5350175887456, 3833.4824798652103, 3854.8458061677497, 3858.575556688762, 3861.9806900965455, 3877.2827027000094, 3249.610046794376, 3317.800931944091, 3327.3678001179696, 3337.7997320160866, 3353.8826141085187, 4858.246971719389, 4866.440359358684, 4880.633952453544, 4882.365292511986, 4887.3402090717655, 4343.67422443318, 4353.717008394444, 4356.8257269709175, 4363.6072753452345, 4371.0, 4986.202207646796, 5172.922406163911, 5233.162693968985, 5238.79044838206, 5255.553277971377, 3610.1046950351015, 3616.258666973264, 3627.111357717376, 3630.4009838376637, 3646.8541258349633, 5438.621909362962, 5447.264619276387, 5470.56235501159, 5479.972600136974, 5481.68276771531, 3576.409892367782, 3658.7438879278193, 3696.2053158571034, 3711.31340701971, 3720.032791474236, 3669.9633003669624, 3690.55713314404, 3708.7033037356946, 3730.2539492101687, 3756.0985363513105, 4354.259775838115, 4365.170617582649, 4366.19225443294, 4372.300431930876, 4383.189110014658, 5259.184826351921, 5282.2340760589495, 5297.284866543045, 5337.733113344395, 5341.332333458317, 1203.4163430736087, 1250.7373451575272, 1257.8427995986926, 1263.5072321794507, 1269.8666640002853, 816.7095988338411, 841.2680967558264, 852.8699473198037, 857.7684025313131, 861.5261606116611, 4470.0, 4471.552844715502, 4485.0, 4501.0, 4607.493175750665, 5386.946130538723, 5391.245225668409, 5394.0, 5396.7571459283645, 5418.91871621926, 4631.189541830234, 4635.096156249567, 4636.400441847557, 4658.417697787777, 4664.137134630037, 2735.8221715588425, 2810.1990932584117, 2832.4618322518654, 2833.70246124154, 2834.4331133772916, 4944.431390390079, 4949.208126699711, 4953.405591329064, 4960.851174464772, 4988.6507944444265, 5374.608299306771, 5380.569554435636, 5388.0, 5402.108652072443, 5414.810481633124, 4733.692309999839, 4835.395575552985, 4870.220764677776, 4886.21820508724, 4921.981987385155, 5174.120399532164, 5180.197069454241, 5184.263271803988, 5194.428612852659, 5267.57859371257, 5181.844544663666, 5201.92197117036, 5230.450802665665, 5232.534890230741, 5246.868828279324, 4649.488556258876, 4809.278608208797, 4835.395575553056, 4907.803687852446, 4936.210206367107, 3840.2895464339185, 3873.5351757788117, 3882.2141814765523, 3888.902777430587, 3894.727369084137, 5224.686518808883, 5268.4731526848545, 5283.656562323436, 5311.892542862469, 5320.228566857862, 4947.777350019186, 5039.622028347815, 5117.641765076409, 5156.0, 5183.637145399936, 5102.923456148086, 5109.821156259513, 5113.335266415343, 5114.343244580143, 5134.922976155286, 5040.521150490697, 5060.316857224375, 5077.238414237894, 5077.543021128116, 5078.568321692697, 4895.290182923527, 5101.413337466239, 5167.088177374396, 5179.507946745053, 5195.350581177353, 5137.998090372342, 5161.967606478795, 5170.870728231825, 5178.974105129601, 5180.7409629519125], "value": 3880.8731623549725, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.9382558656926, 663.2174034639127, 732.194585955449, 777.4907435629661, 784.8665726826441, 11669.474873630686, 12574.497020119206, 12636.620901372973, 12654.304013279267, 12661.746765064705, 12331.013518918488, 12395.628131156058, 12419.441125149368, 12439.067069969744, 12446.937765311184, 650.3756393861898, 666.823291827666, 742.2354974376401, 783.1502819440914, 801.1027649033091, 804.6218277409637, 806.4717609965483, 807.1968391450515, 809.0857331215718, 809.2595275323073, 845.1168528887328, 845.446232717571, 847.7033038436529, 848.101012926297, 848.3298194426395, 833.3832963606948, 836.640244694781, 840.3235395506615, 843.2832092721169, 843.6119385082839, 616.771794436057, 618.1716499890124, 622.2066864747438, 623.2085251730277, 623.9126522286883, 12976.0, 13219.405126769318, 13282.003849711311, 13284.070115091947, 13343.799843002364, 11558.0, 11624.94187529057, 11705.239159454693, 11989.460474278678, 13093.0, 11998.58004969822, 12028.0, 12067.517299308018, 12092.093093017971, 12833.294168820712, 4169.217674376942, 4179.749215047107, 4209.2423363794505, 4243.511996120455, 4377.562243775629, 68160.65919670419, 68181.0, 68757.3124268756, 68947.3105268946, 70302.64848675724, 10073.949630251802, 10209.540570674337, 10225.642102526375, 10314.0, 10376.066154046172, 18030.63938721218, 18189.909050454662, 18225.270989160552, 18286.268549258148, 18298.542536436697, 6426.260979987268, 6460.289368169498, 6474.255460622088, 6764.83087922796, 6778.93221067783, 3543.9645603543636, 3604.1786132788466, 3638.0, 3663.139162296858, 3681.1533347330264, 2786.0527420677067, 2821.3369858083333, 2842.019503271368, 2842.204182828811, 2847.757940575033, 483.8040593559614, 485.32782096796194, 488.36756400461485, 492.5468568916605, 496.5927939089984, 593.4451288045691, 594.6669864875597, 604.4952464691944, 616.1774031667684, 636.4894247875055, 8081.393895457747, 8165.63254653542, 8214.699884032361, 8416.78958026042, 8660.220580147818, 579.7709904587664, 582.9303228575527, 589.7611467355728, 592.520058752412, 619.6963487890991, 4000.5599384067727, 4086.8160932758096, 4123.092919557693, 4148.481439820022, 4263.424437700933, 66654.33345666579, 67078.3292167072, 67287.0, 67346.0, 67378.66310668514, 46202.0, 47097.76451117722, 56612.15081773777, 60378.69810650919, 61062.69468652628, 53593.73203133959, 54255.186172207446, 55467.72266138643, 56040.0, 56604.0, 7651.273129052731, 7895.605219738875, 8029.357651387992, 8060.071094779876, 8180.30467410253, 37165.62834371622, 37536.812315938245, 38065.61934380621, 39026.804865975486, 39351.0, 38889.0, 40114.1977160461, 45180.0, 48565.900580438545, 49718.50281497139, 10978.945105274423, 10995.34027958325, 11031.503582338653, 11240.662780116609, 11440.542378304775, 12466.252024878537, 13451.621405234617, 13760.243186624832, 14041.015439518824, 14671.0, 11899.524019039487, 12041.33772642513, 12272.0, 12555.0, 12599.0, 12765.553205637758, 12906.354682266037, 12980.935095324463, 13065.608031759062, 13406.865931340562, 11234.382108984084, 11711.121665874924, 12236.938815305866, 12259.570915017932, 12303.077269205025, 10136.645217417356, 10353.4305613192, 10696.144308455461, 10984.484964811503, 11145.0, 9344.439333640003, 9972.202223822222, 10324.0, 10457.9477102614, 10463.581456741646], "value": 6403.539553309688, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1571.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 116.0, 114.0, 115.0, 114.0, 117.0, 115.0, 115.0, 115.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 126.0, 124.0, 160.0, 127.0, 126.0, 127.0, 126.0, 147.0, 126.0], "value": 133.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 166.0, 175.0, 166.0, 167.0, 166.0, 163.0, 162.0, 164.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 113.0, 77.0, 76.0, 76.0, 75.0, 101.0, 77.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 106.0, 84.0, 86.0, 85.0, 104.0, 84.0, 85.0, 102.0], "value": 90.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 119.0, 119.0, 118.0, 117.0, 120.0, 117.0, 118.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 155.0, 151.0, 151.0, 152.0, 151.0, 149.0, 152.0, 149.0], "value": 151.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 98.0, 95.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 68.0, 69.0, 72.0, 67.0, 66.0, 66.0], "value": 67.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 67.0, 68.0, 71.0, 68.0, 69.0, 68.0, 68.0], "value": 68.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 85.0, 90.0, 85.0, 91.0, 84.0, 87.0, 85.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 145.0, 136.0, 147.0, 138.0, 133.0, 132.0, 133.0, 190.0, 148.0], "value": 144.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 179.0, 178.0, 181.0, 179.0, 179.0, 185.0, 182.0, 179.0, 182.0], "value": 180.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 69.0, 78.0, 72.0, 68.0, 70.0, 70.0, 72.0, 71.0, 72.0], "value": 71.8, "unit": "score"}]}]} 19:33:20 INFO - Return code: 0 19:33:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:33:20 ERROR - # TBPL SUCCESS # 19:33:20 INFO - Running post-action listener: _resource_record_post_action 19:33:20 INFO - [mozharness: 2017-01-10 03:33:20.789882Z] Finished run-tests step (success) 19:33:20 INFO - Running post-run listener: _resource_record_post_run 19:33:20 INFO - Total resource usage - Wall time: 1199s; CPU: 14.0%; Read bytes: 4096; Write bytes: 394338304; Read time: 12; Write time: 262384 19:33:20 INFO - TinderboxPrint: CPU usage
13.5% 19:33:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 19:33:20 INFO - TinderboxPrint: I/O write bytes / time
394,338,304 / 262,384 19:33:20 INFO - TinderboxPrint: CPU idle
8,272.8 (86.5%) 19:33:20 INFO - TinderboxPrint: CPU user
1,236.0 (12.9%) 19:33:20 INFO - TinderboxPrint: Swap in / out
0 / 0 19:33:20 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110436352; Read time: 0; Write time: 92576 19:33:20 INFO - run-tests - Wall time: 1183s; CPU: 14.0%; Read bytes: 0; Write bytes: 282869760; Read time: 0; Write time: 169768 19:33:21 INFO - Running post-run listener: _upload_blobber_files 19:33:21 INFO - Blob upload gear active. 19:33:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:33:21 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 19:33:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:33:21 INFO - (blobuploader) - INFO - Open directory for files ... 19:33:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:33:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:33:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:33:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:33:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:33:22 INFO - (blobuploader) - INFO - Done attempting. 19:33:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:33:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:33:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:33:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:33:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:33:25 INFO - (blobuploader) - INFO - Done attempting. 19:33:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:33:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:33:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:33:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:33:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:33:26 INFO - (blobuploader) - INFO - Done attempting. 19:33:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:33:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:33:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:33:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:33:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:33:27 INFO - (blobuploader) - INFO - Done attempting. 19:33:27 INFO - (blobuploader) - INFO - Iteration through files over. 19:33:27 INFO - Return code: 0 19:33:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:33:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:33:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/841b5f9d99e6d186a041daa91b07ccabad77bd80c1af3206a04365ed9f727c3d0a5ff26f59cd5dc14b1ecd29fb32c24ea3b8203fc0a8f073334377b3c2c81784", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/923d60c47f05367f5a05f74329d6203486180787a8aaeb4298b0c926afe521518f690486f551cc681b028cf6541dfae9b4f4efb3e4d47866c659c5b570b4c836", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2326367ce1b91d86f183c9509058db5b03be89c2ce0be8553faa3a6863e6653523a21572e8bd52de99cf0279522412fbcf0e22095fe13cd898f5526d16f799cc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2775bd767ad086bd5f17f01308f8bdb9d6b5e755990102ce972624aa2de3269e6066ac3009196e67b8d9700eccb8d529eccc1e720aa0c51c3560c1d746c1ecbd"} 19:33:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:33:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:33:27 INFO - Contents: 19:33:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/841b5f9d99e6d186a041daa91b07ccabad77bd80c1af3206a04365ed9f727c3d0a5ff26f59cd5dc14b1ecd29fb32c24ea3b8203fc0a8f073334377b3c2c81784", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/923d60c47f05367f5a05f74329d6203486180787a8aaeb4298b0c926afe521518f690486f551cc681b028cf6541dfae9b4f4efb3e4d47866c659c5b570b4c836", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2326367ce1b91d86f183c9509058db5b03be89c2ce0be8553faa3a6863e6653523a21572e8bd52de99cf0279522412fbcf0e22095fe13cd898f5526d16f799cc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2775bd767ad086bd5f17f01308f8bdb9d6b5e755990102ce972624aa2de3269e6066ac3009196e67b8d9700eccb8d529eccc1e720aa0c51c3560c1d746c1ecbd"} 19:33:27 INFO - Running post-run listener: copy_logs_to_upload_dir 19:33:27 INFO - Copying logs to upload dir... 19:33:27 INFO - mkdir: /builds/slave/test/build/upload/logs 19:33:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1243.723061 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 43 secs) (at 2017-01-09 19:33:27.377338) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 19:33:27.381022) ========= 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=ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/841b5f9d99e6d186a041daa91b07ccabad77bd80c1af3206a04365ed9f727c3d0a5ff26f59cd5dc14b1ecd29fb32c24ea3b8203fc0a8f073334377b3c2c81784", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/923d60c47f05367f5a05f74329d6203486180787a8aaeb4298b0c926afe521518f690486f551cc681b028cf6541dfae9b4f4efb3e4d47866c659c5b570b4c836", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2326367ce1b91d86f183c9509058db5b03be89c2ce0be8553faa3a6863e6653523a21572e8bd52de99cf0279522412fbcf0e22095fe13cd898f5526d16f799cc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2775bd767ad086bd5f17f01308f8bdb9d6b5e755990102ce972624aa2de3269e6066ac3009196e67b8d9700eccb8d529eccc1e720aa0c51c3560c1d746c1ecbd"} build_url:https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011661 build_url: 'https://queue.taskcluster.net/v1/task/MjGhsuKhQDuTHYnhgCp9zQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/841b5f9d99e6d186a041daa91b07ccabad77bd80c1af3206a04365ed9f727c3d0a5ff26f59cd5dc14b1ecd29fb32c24ea3b8203fc0a8f073334377b3c2c81784", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/923d60c47f05367f5a05f74329d6203486180787a8aaeb4298b0c926afe521518f690486f551cc681b028cf6541dfae9b4f4efb3e4d47866c659c5b570b4c836", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2326367ce1b91d86f183c9509058db5b03be89c2ce0be8553faa3a6863e6653523a21572e8bd52de99cf0279522412fbcf0e22095fe13cd898f5526d16f799cc", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2775bd767ad086bd5f17f01308f8bdb9d6b5e755990102ce972624aa2de3269e6066ac3009196e67b8d9700eccb8d529eccc1e720aa0c51c3560c1d746c1ecbd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-09 19:33:27.406750) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 19:33:27.407076) ========= 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=ed14279e38b05397cf4aa391000001a4-1484017402.428342-1806907064 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-09 19:33:27.489428) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 19:33:27.489749) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-09 19:33:27.490057) ========= ========= Total master_lag: 0.21 =========