builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1485191424.83 results: success (0) revision: 4b053b4106a9b99268312c5fcf8ac1048cc80430 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 09:10:24.829450) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 09:10:24.829923) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 09:10:24.830273) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 09:10:24.845270) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 09:10:24.845552) ========= 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=0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-23 09:10:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 102M=0s 2017-01-23 09:10:25 (102 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.108579 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 09:10:24.968351) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 09:10:24.968681) ========= 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=0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014880 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 09:10:25.018700) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 09:10:25.019046) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4b053b4106a9b99268312c5fcf8ac1048cc80430 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4b053b4106a9b99268312c5fcf8ac1048cc80430 --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=0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-23 09:10:25,281 truncating revision to first 12 chars 2017-01-23 09:10:25,281 Setting DEBUG logging. 2017-01-23 09:10:25,281 attempt 1/10 2017-01-23 09:10:25,281 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4b053b4106a9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-23 09:10:25,671 unpacking tar archive at: mozilla-aurora-4b053b4106a9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.703776 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 09:10:25.737006) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 09:10:25.737462) ========= script_repo_revision: 4b053b4106a9b99268312c5fcf8ac1048cc80430 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 09:10:25.737961) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 09:10:25.738307) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 09:10:25.749513) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-23 09:10:25.749887) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:10:26 INFO - MultiFileLogger online at 20170123 09:10:26 in /builds/slave/test 09:10:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 09:10:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:10:26 INFO - {'append_to_log': False, 09:10:26 INFO - 'base_work_dir': '/builds/slave/test', 09:10:26 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 09:10:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:10:26 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 09:10:26 INFO - 'buildbot_json_path': 'buildprops.json', 09:10:26 INFO - 'config_files': ('talos/linux_config.py',), 09:10:26 INFO - 'default_actions': ('clobber', 09:10:26 INFO - 'read-buildbot-config', 09:10:26 INFO - 'download-and-extract', 09:10:26 INFO - 'populate-webroot', 09:10:26 INFO - 'create-virtualenv', 09:10:26 INFO - 'install', 09:10:26 INFO - 'run-tests'), 09:10:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:10:26 INFO - 'download_minidump_stackwalk': True, 09:10:26 INFO - 'download_symbols': 'ondemand', 09:10:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:10:26 INFO - 'tooltool.py': '/tools/tooltool.py', 09:10:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:10:26 INFO - '/tools/misc-python/virtualenv.py')}, 09:10:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:10:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:10:26 INFO - 'installer_path': 'installer.exe', 09:10:26 INFO - 'log_level': 'info', 09:10:26 INFO - 'log_name': 'talos', 09:10:26 INFO - 'log_to_console': True, 09:10:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:10:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:10:26 INFO - 'opt_config_files': (), 09:10:26 INFO - 'pip_index': False, 09:10:26 INFO - 'sps_profile': False, 09:10:26 INFO - 'sps_profile_interval': 0, 09:10:26 INFO - 'suite': 'dromaeojs', 09:10:26 INFO - 'system_bits': '32', 09:10:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:10:26 INFO - 'title': 'talos-linux64-ix-017', 09:10:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:10:26 INFO - 'use_talos_json': True, 09:10:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:10:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:10:26 INFO - 'work_dir': 'build'} 09:10:26 INFO - [mozharness: 2017-01-23 17:10:26.113063Z] Running clobber step. 09:10:26 INFO - Running pre-action listener: _resource_record_pre_action 09:10:26 INFO - Running main action method: clobber 09:10:26 INFO - rmtree: /builds/slave/test/build 09:10:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:10:26 INFO - Running post-action listener: _resource_record_post_action 09:10:26 INFO - [mozharness: 2017-01-23 17:10:26.590558Z] Finished clobber step (success) 09:10:26 INFO - [mozharness: 2017-01-23 17:10:26.590659Z] Running read-buildbot-config step. 09:10:26 INFO - Running pre-action listener: _resource_record_pre_action 09:10:26 INFO - Running main action method: read_buildbot_config 09:10:26 INFO - Using buildbot properties: 09:10:26 INFO - { 09:10:26 INFO - "project": "", 09:10:26 INFO - "product": "firefox", 09:10:26 INFO - "who": "philringnalda@gmail.com", 09:10:26 INFO - "installer_path": "public/build/target.tar.bz2", 09:10:26 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:10:26 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 09:10:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 09:10:26 INFO - "stage_platform": "linux64", 09:10:26 INFO - "basedir": "/builds/slave/test", 09:10:26 INFO - "buildnumber": 0, 09:10:26 INFO - "platform": "ubuntu64_hw", 09:10:26 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:10:26 INFO - "slavebuilddir": "test", 09:10:26 INFO - "taskId": "Eq2RodbfRsiFu6wqPat3bA", 09:10:26 INFO - "branch": "mozilla-aurora", 09:10:26 INFO - "script_repo_revision": "production", 09:10:26 INFO - "revision": "4b053b4106a9b99268312c5fcf8ac1048cc80430", 09:10:26 INFO - "slavename": "talos-linux64-ix-017", 09:10:26 INFO - "repo_path": "releases/mozilla-aurora" 09:10:26 INFO - } 09:10:26 INFO - Finding installer, test and symbols from parent task. 09:10:26 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Eq2RodbfRsiFu6wqPat3bA'}, attempt #1 09:10:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Eq2RodbfRsiFu6wqPat3bA'}, attempt #1 09:10:27 INFO - Task dependencies: L6V-94QgQkS2BXY6NM7acQ 09:10:27 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ'}, attempt #1 09:10:28 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/target.tar.bz2 09:10:28 INFO - Set test_url: https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/test_packages.json 09:10:28 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/target.crashreporter-symbols.zip 09:10:28 INFO - Running post-action listener: _resource_record_post_action 09:10:28 INFO - [mozharness: 2017-01-23 17:10:28.001384Z] Finished read-buildbot-config step (success) 09:10:28 INFO - [mozharness: 2017-01-23 17:10:28.001602Z] Running download-and-extract step. 09:10:28 INFO - Running pre-action listener: _resource_record_pre_action 09:10:28 INFO - Running main action method: download_and_extract 09:10:28 INFO - mkdir: /builds/slave/test/build/tests 09:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:28 INFO - trying https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/target.test_packages.json 09:10:28 INFO - Downloading https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:10:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:10:28 INFO - Downloaded 896 bytes. 09:10:28 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:10:28 INFO - Using the following test package requirements: 09:10:28 INFO - {u'common': [u'target.common.tests.zip'], 09:10:28 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:10:28 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:10:28 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:10:28 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:10:28 INFO - u'mozbase': [u'target.common.tests.zip'], 09:10:28 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:10:28 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:10:28 INFO - u'web-platform': [u'target.common.tests.zip', 09:10:28 INFO - u'target.web-platform.tests.zip'], 09:10:28 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:10:28 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:10:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/target.common.tests.zip 09:10:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:10:28 INFO - Fetch https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/target.common.tests.zip into memory 09:10:29 INFO - Expected file size: 21846666 09:10:29 INFO - Obtained file size: 21846666 09:10:33 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:10:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/target.common.tests.zip 09:10:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:10:33 INFO - Fetch https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/target.common.tests.zip into memory 09:10:34 INFO - Expected file size: 21846666 09:10:34 INFO - Obtained file size: 21846666 09:10:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/target.talos.tests.zip 09:10:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:10:38 INFO - Fetch https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/target.talos.tests.zip into memory 09:10:39 INFO - Expected file size: 14403485 09:10:39 INFO - Obtained file size: 14403485 09:10:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:10:39 INFO - trying https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/target.tar.bz2 09:10:39 INFO - Downloading https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:10:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:10:41 INFO - Downloaded 65997012 bytes. 09:10:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/target.tar.bz2 09:10:41 INFO - mkdir: /builds/slave/test/properties 09:10:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:10:41 INFO - Writing to file /builds/slave/test/properties/build_url 09:10:41 INFO - Contents: 09:10:41 INFO - build_url:https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/target.tar.bz2 09:10:41 INFO - Running post-action listener: _resource_record_post_action 09:10:41 INFO - Running post-action listener: set_extra_try_arguments 09:10:41 INFO - [mozharness: 2017-01-23 17:10:41.001663Z] Finished download-and-extract step (success) 09:10:41 INFO - [mozharness: 2017-01-23 17:10:41.001760Z] Running populate-webroot step. 09:10:41 INFO - Running pre-action listener: _resource_record_pre_action 09:10:41 INFO - Running main action method: populate_webroot 09:10:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:10:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:10:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:10:41 INFO - '--tppagecycles', 09:10:41 INFO - '7'], 09:10:41 INFO - 'tests': ['tsvgm']}}, 09:10:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:10:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:10:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:10:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:10:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:10:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:10:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:10:41 INFO - 'talos_options': ['--disable-e10s'], 09:10:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:10:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:10:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:10:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:10:41 INFO - 'talos_options': ['--disable-e10s'], 09:10:41 INFO - 'tests': ['damp', 'tps']}, 09:10:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:10:41 INFO - 'tests': ['damp', 'tps']}, 09:10:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:10:41 INFO - 'tests': ['dromaeo_dom']}, 09:10:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:10:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:10:41 INFO - 'tests': ['basic_compositor_video']}, 09:10:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:10:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:10:41 INFO - 'tests': ['a11yr', 09:10:41 INFO - 'ts_paint', 09:10:41 INFO - 'tpaint', 09:10:41 INFO - 'sessionrestore', 09:10:41 INFO - 'sessionrestore_no_auto_restore', 09:10:41 INFO - 'tabpaint']}, 09:10:41 INFO - 'other-e10s': {'tests': ['a11yr', 09:10:41 INFO - 'ts_paint', 09:10:41 INFO - 'tpaint', 09:10:41 INFO - 'sessionrestore', 09:10:41 INFO - 'sessionrestore_no_auto_restore', 09:10:41 INFO - 'tabpaint']}, 09:10:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:10:41 INFO - 'ts_paint', 09:10:41 INFO - 'tpaint', 09:10:41 INFO - 'sessionrestore', 09:10:41 INFO - 'sessionrestore_no_auto_restore', 09:10:41 INFO - 'tabpaint']}, 09:10:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:10:41 INFO - 'ts_paint', 09:10:41 INFO - 'tpaint', 09:10:41 INFO - 'sessionrestore', 09:10:41 INFO - 'sessionrestore_no_auto_restore', 09:10:41 INFO - 'tabpaint']}, 09:10:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:10:41 INFO - 'tests': ['a11yr', 09:10:41 INFO - 'ts_paint', 09:10:41 INFO - 'tpaint', 09:10:41 INFO - 'sessionrestore', 09:10:41 INFO - 'sessionrestore_no_auto_restore', 09:10:41 INFO - 'tabpaint']}, 09:10:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:10:41 INFO - 'tests': ['a11yr', 09:10:41 INFO - 'ts_paint', 09:10:41 INFO - 'tpaint', 09:10:41 INFO - 'sessionrestore', 09:10:41 INFO - 'sessionrestore_no_auto_restore', 09:10:41 INFO - 'tabpaint']}, 09:10:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:10:41 INFO - 'tests': ['tsvgx', 09:10:41 INFO - 'tsvgr_opacity', 09:10:41 INFO - 'tart', 09:10:41 INFO - 'tscrollx', 09:10:41 INFO - 'cart', 09:10:41 INFO - 'tsvg_static']}, 09:10:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:10:41 INFO - 'tsvgr_opacity', 09:10:41 INFO - 'tart', 09:10:41 INFO - 'tscrollx', 09:10:41 INFO - 'cart', 09:10:41 INFO - 'tsvg_static']}, 09:10:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:10:41 INFO - 'talos_options': ['--disable-e10s'], 09:10:41 INFO - 'tests': ['tp5o']}, 09:10:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:10:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:10:41 INFO - 'talos_options': ['--disable-e10s', 09:10:41 INFO - '--xperf_path', 09:10:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:10:41 INFO - 'tests': ['tp5n']}, 09:10:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:10:41 INFO - 'talos_options': ['--xperf_path', 09:10:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:10:41 INFO - 'tests': ['tp5n']}}, 09:10:41 INFO - 'talos.zip': {'path': '', 09:10:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:10:41 INFO - Running post-action listener: _resource_record_post_action 09:10:41 INFO - [mozharness: 2017-01-23 17:10:41.014930Z] Finished populate-webroot step (success) 09:10:41 INFO - [mozharness: 2017-01-23 17:10:41.015021Z] Running create-virtualenv step. 09:10:41 INFO - Running pre-action listener: _resource_record_pre_action 09:10:41 INFO - Running main action method: create_virtualenv 09:10:41 INFO - Creating virtualenv /builds/slave/test/build/venv 09:10:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:10:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:10:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:10:41 INFO - Using real prefix '/usr' 09:10:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:10:41 INFO - Installing distribute.............................................................................................................................................................................................done. 09:10:43 INFO - Installing pip.................done. 09:10:43 INFO - Return code: 0 09:10:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:10:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:10:43 INFO - Reading from file tmpfile_stdout 09:10:43 INFO - Output received: 09:10:43 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:10:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:10:43 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')]} 09:10:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:43 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')]} 09:10:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:43 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 0x15bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1788a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192ad00>, '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 0x192ba00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192beb0>, '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': '0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:43 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 09:10:43 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 09:10:43 INFO - Using env: {'DISPLAY': ':0', 09:10:43 INFO - 'HOME': '/home/cltbld', 09:10:43 INFO - 'LANG': 'en_US.UTF-8', 09:10:43 INFO - 'LANGUAGE': 'en_US:en', 09:10:43 INFO - 'LOGNAME': 'cltbld', 09:10:43 INFO - 'MAIL': '/var/mail/cltbld', 09:10:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:43 INFO - 'MOZ_NO_REMOTE': '1', 09:10:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:43 INFO - 'NO_EM_RESTART': '1', 09:10:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:43 INFO - 'PWD': '/builds/slave/test', 09:10:43 INFO - 'SHELL': '/bin/bash', 09:10:43 INFO - 'SHLVL': '1', 09:10:43 INFO - 'TERM': 'linux', 09:10:43 INFO - 'TMOUT': '86400', 09:10:43 INFO - 'USER': 'cltbld', 09:10:43 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813', 09:10:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:43 INFO - '_': '/tools/buildbot/bin/python'} 09:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:10:44 INFO - Cleaning up... 09:10:44 INFO - Return code: 0 09:10:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:10:44 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')]} 09:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:44 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')]} 09:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:44 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 0x15bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1788a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192ad00>, '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 0x192ba00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192beb0>, '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': '0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:44 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 09:10:44 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 09:10:44 INFO - Using env: {'DISPLAY': ':0', 09:10:44 INFO - 'HOME': '/home/cltbld', 09:10:44 INFO - 'LANG': 'en_US.UTF-8', 09:10:44 INFO - 'LANGUAGE': 'en_US:en', 09:10:44 INFO - 'LOGNAME': 'cltbld', 09:10:44 INFO - 'MAIL': '/var/mail/cltbld', 09:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:44 INFO - 'MOZ_NO_REMOTE': '1', 09:10:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:44 INFO - 'NO_EM_RESTART': '1', 09:10:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:44 INFO - 'PWD': '/builds/slave/test', 09:10:44 INFO - 'SHELL': '/bin/bash', 09:10:44 INFO - 'SHLVL': '1', 09:10:44 INFO - 'TERM': 'linux', 09:10:44 INFO - 'TMOUT': '86400', 09:10:44 INFO - 'USER': 'cltbld', 09:10:44 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813', 09:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:44 INFO - '_': '/tools/buildbot/bin/python'} 09:10:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:44 INFO - Downloading/unpacking psutil>=3.1.1 09:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:44 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 09:10:44 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 09:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:10:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:10:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:10:46 INFO - Installing collected packages: psutil 09:10:46 INFO - Running setup.py install for psutil 09:10:46 INFO - building 'psutil._psutil_linux' extension 09:10:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 09:10:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 09:10:46 INFO - building 'psutil._psutil_posix' extension 09:10:46 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 09:10:46 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 09:10:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:10:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:10:46 INFO - Successfully installed psutil 09:10:46 INFO - Cleaning up... 09:10:46 INFO - Return code: 0 09:10:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:10: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')]} 09:10:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10: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')]} 09:10:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:46 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 0x15bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1788a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192ad00>, '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 0x192ba00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192beb0>, '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': '0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:46 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 09:10:46 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 09:10:46 INFO - Using env: {'DISPLAY': ':0', 09:10:46 INFO - 'HOME': '/home/cltbld', 09:10:46 INFO - 'LANG': 'en_US.UTF-8', 09:10:46 INFO - 'LANGUAGE': 'en_US:en', 09:10:46 INFO - 'LOGNAME': 'cltbld', 09:10:46 INFO - 'MAIL': '/var/mail/cltbld', 09:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:46 INFO - 'MOZ_NO_REMOTE': '1', 09:10:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:46 INFO - 'NO_EM_RESTART': '1', 09:10:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:46 INFO - 'PWD': '/builds/slave/test', 09:10:46 INFO - 'SHELL': '/bin/bash', 09:10:46 INFO - 'SHLVL': '1', 09:10:46 INFO - 'TERM': 'linux', 09:10:46 INFO - 'TMOUT': '86400', 09:10:46 INFO - 'USER': 'cltbld', 09:10:46 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813', 09:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:46 INFO - '_': '/tools/buildbot/bin/python'} 09:10:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:47 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 09:10:47 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 09:10:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:10:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:10:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:10:49 INFO - Installing collected packages: mozsystemmonitor 09:10:49 INFO - Running setup.py install for mozsystemmonitor 09:10:49 INFO - Successfully installed mozsystemmonitor 09:10:49 INFO - Cleaning up... 09:10:49 INFO - Return code: 0 09:10:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:10:49 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')]} 09:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:49 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')]} 09:10:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:49 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 0x15bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1788a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192ad00>, '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 0x192ba00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192beb0>, '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': '0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:49 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 09:10:49 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 09:10:49 INFO - Using env: {'DISPLAY': ':0', 09:10:49 INFO - 'HOME': '/home/cltbld', 09:10:49 INFO - 'LANG': 'en_US.UTF-8', 09:10:49 INFO - 'LANGUAGE': 'en_US:en', 09:10:49 INFO - 'LOGNAME': 'cltbld', 09:10:49 INFO - 'MAIL': '/var/mail/cltbld', 09:10:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:49 INFO - 'MOZ_NO_REMOTE': '1', 09:10:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:49 INFO - 'NO_EM_RESTART': '1', 09:10:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:49 INFO - 'PWD': '/builds/slave/test', 09:10:49 INFO - 'SHELL': '/bin/bash', 09:10:49 INFO - 'SHLVL': '1', 09:10:49 INFO - 'TERM': 'linux', 09:10:49 INFO - 'TMOUT': '86400', 09:10:49 INFO - 'USER': 'cltbld', 09:10:49 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813', 09:10:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:49 INFO - '_': '/tools/buildbot/bin/python'} 09:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:49 INFO - Downloading/unpacking jsonschema==2.5.1 09:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:49 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 09:10:49 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 09:10:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:10:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:51 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 09:10:51 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 09:10:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:51 INFO - Downloading functools32-3.2.3-2.tar.gz 09:10:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:10:52 INFO - warning: no files found matching '*.txt' 09:10:52 INFO - no previously-included directories found matching 'build' 09:10:52 INFO - no previously-included directories found matching 'dist' 09:10:52 INFO - no previously-included directories found matching '.git*' 09:10:52 INFO - Installing collected packages: jsonschema, functools32 09:10:52 INFO - Running setup.py install for functools32 09:10:52 INFO - warning: no files found matching '*.txt' 09:10:52 INFO - no previously-included directories found matching 'build' 09:10:52 INFO - no previously-included directories found matching 'dist' 09:10:52 INFO - no previously-included directories found matching '.git*' 09:10:52 INFO - Successfully installed jsonschema functools32 09:10:52 INFO - Cleaning up... 09:10:52 INFO - Return code: 0 09:10:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:10:52 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')]} 09:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:52 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')]} 09:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:52 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 0x15bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1788a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192ad00>, '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 0x192ba00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192beb0>, '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': '0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:52 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 09:10:52 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 09:10:52 INFO - Using env: {'DISPLAY': ':0', 09:10:52 INFO - 'HOME': '/home/cltbld', 09:10:52 INFO - 'LANG': 'en_US.UTF-8', 09:10:52 INFO - 'LANGUAGE': 'en_US:en', 09:10:52 INFO - 'LOGNAME': 'cltbld', 09:10:52 INFO - 'MAIL': '/var/mail/cltbld', 09:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:52 INFO - 'MOZ_NO_REMOTE': '1', 09:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:52 INFO - 'NO_EM_RESTART': '1', 09:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:52 INFO - 'PWD': '/builds/slave/test', 09:10:52 INFO - 'SHELL': '/bin/bash', 09:10:52 INFO - 'SHLVL': '1', 09:10:52 INFO - 'TERM': 'linux', 09:10:52 INFO - 'TMOUT': '86400', 09:10:52 INFO - 'USER': 'cltbld', 09:10:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813', 09:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:52 INFO - '_': '/tools/buildbot/bin/python'} 09:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:10:52 INFO - Cleaning up... 09:10:52 INFO - Return code: 0 09:10:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:10:52 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')]} 09:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:52 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')]} 09:10:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:52 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 0x15bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1788a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192ad00>, '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 0x192ba00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192beb0>, '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': '0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:52 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 09:10:52 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 09:10:52 INFO - Using env: {'DISPLAY': ':0', 09:10:52 INFO - 'HOME': '/home/cltbld', 09:10:52 INFO - 'LANG': 'en_US.UTF-8', 09:10:52 INFO - 'LANGUAGE': 'en_US:en', 09:10:52 INFO - 'LOGNAME': 'cltbld', 09:10:52 INFO - 'MAIL': '/var/mail/cltbld', 09:10:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:52 INFO - 'MOZ_NO_REMOTE': '1', 09:10:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:52 INFO - 'NO_EM_RESTART': '1', 09:10:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:52 INFO - 'PWD': '/builds/slave/test', 09:10:52 INFO - 'SHELL': '/bin/bash', 09:10:52 INFO - 'SHLVL': '1', 09:10:52 INFO - 'TERM': 'linux', 09:10:52 INFO - 'TMOUT': '86400', 09:10:52 INFO - 'USER': 'cltbld', 09:10:52 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813', 09:10:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:52 INFO - '_': '/tools/buildbot/bin/python'} 09:10:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:52 INFO - Downloading/unpacking blobuploader==1.2.4 09:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:52 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 09:10:52 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 09:10:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:55 INFO - Downloading blobuploader-1.2.4.tar.gz 09:10:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:10:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:55 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 09:10:55 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 09:10:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:10:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:56 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 09:10:56 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 09:10:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:56 INFO - Downloading docopt-0.6.1.tar.gz 09:10:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:10:56 INFO - Installing collected packages: blobuploader, requests, docopt 09:10:56 INFO - Running setup.py install for blobuploader 09:10:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:10:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:10:56 INFO - Running setup.py install for requests 09:10:56 INFO - Running setup.py install for docopt 09:10:57 INFO - Successfully installed blobuploader requests docopt 09:10:57 INFO - Cleaning up... 09:10:57 INFO - Return code: 0 09:10:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:10: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')]} 09:10:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10: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')]} 09:10:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:57 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 0x15bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1788a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192ad00>, '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 0x192ba00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192beb0>, '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': '0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:10:57 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 09:10:57 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 09:10:57 INFO - Using env: {'DISPLAY': ':0', 09:10:57 INFO - 'HOME': '/home/cltbld', 09:10:57 INFO - 'LANG': 'en_US.UTF-8', 09:10:57 INFO - 'LANGUAGE': 'en_US:en', 09:10:57 INFO - 'LOGNAME': 'cltbld', 09:10:57 INFO - 'MAIL': '/var/mail/cltbld', 09:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:57 INFO - 'MOZ_NO_REMOTE': '1', 09:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:10:57 INFO - 'NO_EM_RESTART': '1', 09:10:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:57 INFO - 'PWD': '/builds/slave/test', 09:10:57 INFO - 'SHELL': '/bin/bash', 09:10:57 INFO - 'SHLVL': '1', 09:10:57 INFO - 'TERM': 'linux', 09:10:57 INFO - 'TMOUT': '86400', 09:10:57 INFO - 'USER': 'cltbld', 09:10:57 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813', 09:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:57 INFO - '_': '/tools/buildbot/bin/python'} 09:10:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:10:57 INFO - Running setup.py (path:/tmp/pip-N2ewPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:10:57 INFO - Running setup.py (path:/tmp/pip-OSBF8W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:10:57 INFO - Running setup.py (path:/tmp/pip-GjUUNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:10:57 INFO - Running setup.py (path:/tmp/pip-OWWx_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:10:57 INFO - Running setup.py (path:/tmp/pip-dOUODb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:10:57 INFO - Running setup.py (path:/tmp/pip-EJv1Qn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:10:57 INFO - Running setup.py (path:/tmp/pip-NLAmy6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:10:57 INFO - Running setup.py (path:/tmp/pip-J2TLoF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:10:57 INFO - Running setup.py (path:/tmp/pip-aXzRpF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:10:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:10:57 INFO - Running setup.py (path:/tmp/pip-OH_lON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:10:58 INFO - Running setup.py (path:/tmp/pip-jXw4hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:10:58 INFO - Running setup.py (path:/tmp/pip-abj4Kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:10:58 INFO - Running setup.py (path:/tmp/pip-9mbxZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:10:58 INFO - Running setup.py (path:/tmp/pip-o3hLuL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:10:58 INFO - Running setup.py (path:/tmp/pip-dOEPDU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:10:58 INFO - Running setup.py (path:/tmp/pip-5sGVuk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:10:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:10:58 INFO - Running setup.py (path:/tmp/pip-famxGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:10:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:10:58 INFO - Running setup.py install for manifestparser 09:10:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:10:58 INFO - Running setup.py install for mozcrash 09:10:58 INFO - Running setup.py install for mozdebug 09:10:58 INFO - Running setup.py install for mozdevice 09:10:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:10:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:10:58 INFO - Running setup.py install for mozfile 09:10:59 INFO - Running setup.py install for mozhttpd 09:10:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:10:59 INFO - Running setup.py install for mozinfo 09:10:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:10:59 INFO - Running setup.py install for mozInstall 09:10:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:10:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:10:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:10:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:10:59 INFO - Running setup.py install for mozleak 09:10:59 INFO - Running setup.py install for mozlog 09:10:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:10:59 INFO - Running setup.py install for moznetwork 09:10:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:10:59 INFO - Running setup.py install for mozprocess 09:10:59 INFO - Running setup.py install for mozprofile 09:10:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:10:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:10:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:10:59 INFO - Running setup.py install for mozrunner 09:11:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:11:00 INFO - Running setup.py install for mozscreenshot 09:11:00 INFO - Running setup.py install for moztest 09:11:00 INFO - Running setup.py install for mozversion 09:11:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:11:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:11:00 INFO - Cleaning up... 09:11:00 INFO - Return code: 0 09:11:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11:00 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')]} 09:11:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:00 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')]} 09:11:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:00 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 0x15bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1788a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192ad00>, '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 0x192ba00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192beb0>, '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': '0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:11:00 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 09:11:00 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 09:11:00 INFO - Using env: {'DISPLAY': ':0', 09:11:00 INFO - 'HOME': '/home/cltbld', 09:11:00 INFO - 'LANG': 'en_US.UTF-8', 09:11:00 INFO - 'LANGUAGE': 'en_US:en', 09:11:00 INFO - 'LOGNAME': 'cltbld', 09:11:00 INFO - 'MAIL': '/var/mail/cltbld', 09:11:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:00 INFO - 'MOZ_NO_REMOTE': '1', 09:11:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:00 INFO - 'NO_EM_RESTART': '1', 09:11:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:00 INFO - 'PWD': '/builds/slave/test', 09:11:00 INFO - 'SHELL': '/bin/bash', 09:11:00 INFO - 'SHLVL': '1', 09:11:00 INFO - 'TERM': 'linux', 09:11:00 INFO - 'TMOUT': '86400', 09:11:00 INFO - 'USER': 'cltbld', 09:11:00 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813', 09:11:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:00 INFO - '_': '/tools/buildbot/bin/python'} 09:11:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:11:00 INFO - Running setup.py (path:/tmp/pip-iattg7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:11:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:11:00 INFO - Running setup.py (path:/tmp/pip-fDc0oQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:11:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:11:00 INFO - Running setup.py (path:/tmp/pip-VHNx1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:11:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:11:00 INFO - Running setup.py (path:/tmp/pip-INBAEh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:11:00 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)) 09:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:11:00 INFO - Running setup.py (path:/tmp/pip-tZZpUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:11:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:11:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:11:00 INFO - Running setup.py (path:/tmp/pip-FScyOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:11:01 INFO - Running setup.py (path:/tmp/pip-PI3oS0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:11:01 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)) 09:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:11:01 INFO - Running setup.py (path:/tmp/pip-CbNlKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:11:01 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)) 09:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:11:01 INFO - Running setup.py (path:/tmp/pip-uzXFP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:11:01 INFO - Running setup.py (path:/tmp/pip-9CSS2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:11:01 INFO - Running setup.py (path:/tmp/pip-yyTaRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:11:01 INFO - Running setup.py (path:/tmp/pip-pZ7Cta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:11:01 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)) 09:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:11:01 INFO - Running setup.py (path:/tmp/pip-tKnI3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:11:01 INFO - Running setup.py (path:/tmp/pip-jDfHoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:01 INFO - Running setup.py (path:/tmp/pip-pjCV61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:11:01 INFO - Running setup.py (path:/tmp/pip-1gPTF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:11:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:11:01 INFO - Running setup.py (path:/tmp/pip-szxG12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:11:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:11:01 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)) 09:11:01 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)) 09:11:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:01 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 09:11:01 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 09:11:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:11:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:11:03 INFO - Downloading blessings-1.6.tar.gz 09:11:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:11:03 INFO - Installing collected packages: blessings 09:11:03 INFO - Running setup.py install for blessings 09:11:04 INFO - Successfully installed blessings 09:11:04 INFO - Cleaning up... 09:11:04 INFO - Return code: 0 09:11:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:11:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:11:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:11:04 INFO - Reading from file tmpfile_stdout 09:11:04 INFO - Current package versions: 09:11:04 INFO - argparse == 1.2.1 09:11:04 INFO - blessings == 1.6 09:11:04 INFO - blobuploader == 1.2.4 09:11:04 INFO - docopt == 0.6.1 09:11:04 INFO - functools32 == 3.2.3-2 09:11:04 INFO - jsonschema == 2.5.1 09:11:04 INFO - manifestparser == 1.1 09:11:04 INFO - mozInstall == 1.12 09:11:04 INFO - mozcrash == 1.0 09:11:04 INFO - mozdebug == 0.1 09:11:04 INFO - mozdevice == 0.49 09:11:04 INFO - mozfile == 1.2 09:11:04 INFO - mozhttpd == 0.7 09:11:04 INFO - mozinfo == 0.9 09:11:04 INFO - mozleak == 0.1 09:11:04 INFO - mozlog == 3.4 09:11:04 INFO - moznetwork == 0.27 09:11:04 INFO - mozprocess == 0.24 09:11:04 INFO - mozprofile == 0.28 09:11:04 INFO - mozrunner == 6.13 09:11:04 INFO - mozscreenshot == 0.1 09:11:04 INFO - mozsystemmonitor == 0.3 09:11:04 INFO - moztest == 0.8 09:11:04 INFO - mozversion == 1.4 09:11:04 INFO - psutil == 3.1.1 09:11:04 INFO - requests == 1.2.3 09:11:04 INFO - wsgiref == 0.1.2 09:11:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:11: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')]} 09:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11: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')]} 09:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11:04 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 0x15bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1788a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192ad00>, '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 0x192ba00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192beb0>, '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': '0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:11:04 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 09:11:04 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 09:11:04 INFO - Using env: {'DISPLAY': ':0', 09:11:04 INFO - 'HOME': '/home/cltbld', 09:11:04 INFO - 'LANG': 'en_US.UTF-8', 09:11:04 INFO - 'LANGUAGE': 'en_US:en', 09:11:04 INFO - 'LOGNAME': 'cltbld', 09:11:04 INFO - 'MAIL': '/var/mail/cltbld', 09:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:04 INFO - 'MOZ_NO_REMOTE': '1', 09:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:04 INFO - 'NO_EM_RESTART': '1', 09:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:04 INFO - 'PWD': '/builds/slave/test', 09:11:04 INFO - 'SHELL': '/bin/bash', 09:11:04 INFO - 'SHLVL': '1', 09:11:04 INFO - 'TERM': 'linux', 09:11:04 INFO - 'TMOUT': '86400', 09:11:04 INFO - 'USER': 'cltbld', 09:11:04 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813', 09:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:04 INFO - '_': '/tools/buildbot/bin/python'} 09:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:11:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:11:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:11:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:11:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:11:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:11:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:11:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:11:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:11:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:11:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:11:04 INFO - Cleaning up... 09:11:04 INFO - Return code: 0 09:11:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:11: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')]} 09:11:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:11:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11: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')]} 09:11:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:11:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:11: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15bb1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1788a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192d980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192ad00>, '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 0x192ba00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192beb0>, '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': '0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 09:11: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', 'jsonschema'] in /builds/slave/test/build 09:11: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 jsonschema 09:11:04 INFO - Using env: {'DISPLAY': ':0', 09:11:04 INFO - 'HOME': '/home/cltbld', 09:11:04 INFO - 'LANG': 'en_US.UTF-8', 09:11:04 INFO - 'LANGUAGE': 'en_US:en', 09:11:04 INFO - 'LOGNAME': 'cltbld', 09:11:04 INFO - 'MAIL': '/var/mail/cltbld', 09:11:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:04 INFO - 'MOZ_NO_REMOTE': '1', 09:11:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:04 INFO - 'NO_EM_RESTART': '1', 09:11:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:04 INFO - 'PWD': '/builds/slave/test', 09:11:04 INFO - 'SHELL': '/bin/bash', 09:11:04 INFO - 'SHLVL': '1', 09:11:04 INFO - 'TERM': 'linux', 09:11:04 INFO - 'TMOUT': '86400', 09:11:04 INFO - 'USER': 'cltbld', 09:11:04 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813', 09:11:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:04 INFO - '_': '/tools/buildbot/bin/python'} 09:11:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:11:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:11:04 INFO - Cleaning up... 09:11:04 INFO - Return code: 0 09:11:04 INFO - Running post-action listener: _resource_record_post_action 09:11:04 INFO - Running post-action listener: _start_resource_monitoring 09:11:04 INFO - Starting resource monitoring. 09:11:04 INFO - [mozharness: 2017-01-23 17:11:04.826339Z] Finished create-virtualenv step (success) 09:11:04 INFO - [mozharness: 2017-01-23 17:11:04.826843Z] Running install step. 09:11:04 INFO - Running pre-action listener: _resource_record_pre_action 09:11:04 INFO - Running main action method: install 09:11:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:11:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:11:05 INFO - Reading from file tmpfile_stdout 09:11:05 INFO - Detecting whether we're running mozinstall >=1.0... 09:11:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:11:05 INFO - Reading from file tmpfile_stdout 09:11:05 INFO - Output received: 09:11:05 INFO - Usage: mozinstall [options] installer 09:11:05 INFO - Options: 09:11:05 INFO - -h, --help show this help message and exit 09:11:05 INFO - -d DEST, --destination=DEST 09:11:05 INFO - Directory to install application into. [default: 09:11:05 INFO - "/builds/slave/test"] 09:11:05 INFO - --app=APP Application being installed. [default: firefox] 09:11:05 INFO - mkdir: /builds/slave/test/build/application 09:11:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:11:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:11:21 INFO - Reading from file tmpfile_stdout 09:11:21 INFO - Output received: 09:11:21 INFO - /builds/slave/test/build/application/firefox/firefox 09:11:21 INFO - Running post-action listener: _resource_record_post_action 09:11:21 INFO - [mozharness: 2017-01-23 17:11:21.611175Z] Finished install step (success) 09:11:21 INFO - [mozharness: 2017-01-23 17:11:21.611451Z] Running run-tests step. 09:11:21 INFO - Running pre-action listener: _resource_record_pre_action 09:11:21 INFO - Running main action method: run_tests 09:11:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:11:21 INFO - Python 2.7.3 09:11:21 INFO - Return code: 0 09:11:21 INFO - grabbing minidump binary from tooltool 09:11: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')]} 09:11:21 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 0x192ad00>, '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 0x192ba00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x192beb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:11:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:11:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:11:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:11:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:11:21 INFO - Return code: 0 09:11:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:11:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:11:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:11:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:11:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:11:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:11:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:11:21 INFO - Using env: {'DISPLAY': ':0', 09:11:21 INFO - 'HOME': '/home/cltbld', 09:11:21 INFO - 'LANG': 'en_US.UTF-8', 09:11:21 INFO - 'LANGUAGE': 'en_US:en', 09:11:21 INFO - 'LOGNAME': 'cltbld', 09:11:21 INFO - 'MAIL': '/var/mail/cltbld', 09:11:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:11:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:11:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:11:21 INFO - 'MOZ_NO_REMOTE': '1', 09:11:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:11:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:11:21 INFO - 'NO_EM_RESTART': '1', 09:11:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:11:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:11:21 INFO - 'PWD': '/builds/slave/test', 09:11:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:11:21 INFO - 'SHELL': '/bin/bash', 09:11:21 INFO - 'SHLVL': '1', 09:11:21 INFO - 'TERM': 'linux', 09:11:21 INFO - 'TMOUT': '86400', 09:11:21 INFO - 'USER': 'cltbld', 09:11:21 INFO - 'XDG_SESSION_COOKIE': '0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813', 09:11:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:11:21 INFO - '_': '/tools/buildbot/bin/python'} 09:11:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:11:21 INFO - mozversion application_buildid: 20170123160807 09:11:21 INFO - mozversion application_changeset: 4b053b4106a9b99268312c5fcf8ac1048cc80430 09:11:21 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:11:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:11:21 INFO - mozversion application_name: Firefox 09:11:21 INFO - mozversion application_remotingname: firefox-dev 09:11:21 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:11:21 INFO - mozversion application_vendor: Mozilla 09:11:21 INFO - mozversion application_version: 53.0a2 09:11:21 INFO - mozversion platform_buildid: 20170123160807 09:11:21 INFO - mozversion platform_changeset: 4b053b4106a9b99268312c5fcf8ac1048cc80430 09:11:21 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:11:21 INFO - mozversion platform_version: 53.0a2 09:11:21 INFO - using testdate: 1485191481 09:11:21 INFO - actual date: 1485191481 09:11:21 INFO - starting webserver on 'localhost:57065' 09:11:21 INFO - SUITE-START | Running 2 tests 09:11:21 INFO - TEST-START | dromaeo_css 09:11:21 INFO - operating with platform_type : linux_ 09:11:21 INFO - Initialising browser for dromaeo_css test... 09:11:21 INFO - TEST-INFO | started process 15849 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsMHjRl/profile http://localhost:57065/getInfo.html) 09:11:25 INFO - PROCESS | 15849 | __metrics Screen width/height:1600/1200 09:11:25 INFO - PROCESS | 15849 | colorDepth:24 09:11:25 INFO - PROCESS | 15849 | Browser inner width/height: 1024/697 09:11:25 INFO - PROCESS | 15849 | __metrics 09:11:26 INFO - PROCESS | 15849 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 09:11:26 INFO - PROCESS | 15849 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:11:26 INFO - PROCESS | 15849 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:11:26 INFO - PROCESS | 15849 | console.error: PushService: 09:11:26 INFO - PROCESS | 15849 | stateChangeProcessEnqueue: Error transitioning state 09:11:26 INFO - PROCESS | 15849 | UnknownError 09:11:27 INFO - TEST-INFO | 15849: exit 0 09:11:27 INFO - Browser initialized. 09:11:27 INFO - Running cycle 1/1 for dromaeo_css test... 09:11:27 INFO - TEST-INFO | started process 15938 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsMHjRl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:11:39 INFO - PROCESS | 15938 | RSS: Main: 138526720 09:11:39 INFO - PROCESS | 15938 | 09:14:39 INFO - PROCESS | 15938 | Cycle 1(1): loaded http://localhost:57065/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57065/tests/dromaeo/cssquery-ext.html) 09:14:40 INFO - PROCESS | 15938 | RSS: Main: 242425856 09:14:40 INFO - PROCESS | 15938 | 09:16:29 INFO - PROCESS | 15938 | ************************* 09:16:29 INFO - PROCESS | 15938 | A coding exception was thrown and uncaught in a Task. 09:16:29 INFO - PROCESS | 15938 | 09:16:29 ERROR - PROCESS | 15938 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:16:29 INFO - PROCESS | 15938 | Full stack: 09:16:29 INFO - PROCESS | 15938 | ************************* 09:17:42 INFO - PROCESS | 15938 | Cycle 1(1): loaded http://localhost:57065/tests/dromaeo/cssquery-ext.html (next: http://localhost:57065/tests/dromaeo/cssquery-jquery.html) 09:17:43 INFO - PROCESS | 15938 | RSS: Main: 221220864 09:17:43 INFO - PROCESS | 15938 | 09:20:45 INFO - PROCESS | 15938 | Cycle 1(1): loaded http://localhost:57065/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57065/tests/dromaeo/cssquery-mootools.html) 09:20:45 INFO - PROCESS | 15938 | RSS: Main: 222494720 09:20:45 INFO - PROCESS | 15938 | 09:23:47 INFO - PROCESS | 15938 | Cycle 1(1): loaded http://localhost:57065/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57065/tests/dromaeo/cssquery-prototype.html) 09:23:48 INFO - PROCESS | 15938 | RSS: Main: 216399872 09:23:48 INFO - PROCESS | 15938 | 09:26:51 INFO - PROCESS | 15938 | Cycle 1(1): loaded http://localhost:57065/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57065/tests/dromaeo/cssquery-yui.html) 09:26:51 INFO - PROCESS | 15938 | RSS: Main: 171655168 09:26:51 INFO - PROCESS | 15938 | 09:29:54 INFO - PROCESS | 15938 | Cycle 1(1): loaded http://localhost:57065/tests/dromaeo/cssquery-yui.html (next: http://localhost:57065/tests/dromaeo/cssquery-dojo.html) 09:29:54 INFO - PROCESS | 15938 | RSS: Main: 264859648 09:29:54 INFO - PROCESS | 15938 | 09:29:54 INFO - PROCESS | 15938 | __start_tp_report 09:29:54 INFO - PROCESS | 15938 | _x_x_mozilla_page_load 09:29:54 INFO - PROCESS | 15938 | _x_x_mozilla_page_load_details 09:29:54 INFO - PROCESS | 15938 | |i|pagename|runs| 09:29:54 INFO - PROCESS | 15938 | |0;dojo.html;3282.4748040313552;3322.4351860183765;3322.45179545375;3349.4808304712747;3368.713659338956;5506.5870059745475;5589.049861523541;5596.468335508121;5608.270924779783;5619.381867994517;5489.3961664217;5518.365387980383;5550.306211723535;5565.777368905249;5588.86027849303;4885.413750349954;4936.901261974758;4972.602191824645;5008.7996480140755;5009.824656137036;4877.926831097537;4897.583705385029;4976.4525902150735;5017.69893806371;5025.924611130836;4838.540338667821;4868.634852386085;4918.458969513351;4948.950510494885;4974.900501989958;4971.602271818246;4974.1295273327205;4987.0524600325825;4987.177115775893;5010.0981823271795;4805.591524720368;4913.140200464904;4933.481984391623;4946.678465899741;4974.129527332739;5339.9733001335135;5378.46215378463;5477.178423236506;5483.067878460672;5539.25220095286;5929.466348028655;5938.138969849391;5941.970290148565;5942.197803296543;5944.078667806497;5926.348101708809;5969.522438204976;5977.043673012297;5988.880222395528;5989.610675306091;5432.6468779529205;5454.972725136349;5471.261379713767;5502.80740174092;5518;6033.758649653964;6034.336223015464;6035.547333949971;6037.184980027728;6071.51427885768;5761.279840019997;5796.1305804129715;5798.82603521895;5805.535557155502;5806.65160090396;5756.769729210869;5805.477507024388;5833.970830145822;5850.707464626752;5910.556708246899;5887.411258874078;5938.673372964528;5942.673152976541;5957.434043765836;5976.133460648269;5879.794207202727;5888.735006924699;5889.705514724246;5889.852753681193;5895.7052147393315;4462.642988560908;4492.124035813051;4522.773861306921;4576.4508259009135;4583.106294272585;4049.8380064797666;4071.0840060986043;4093.795310234536;4099.8360065597635;4113.465249517543;5764.394738552475;5767.711614419262;5768.538516918637;5769.826905192851;5775.971120144456;5766.5675074368755;5861.443162899603;5891.499222566044;5932.644041357532;5999.910001349983;5648.237487939158;5651.9152212716845;5657.547396208293;5659.5755318351285;5671.546276297886;5083.669561478492;5092.287079808756;5093.032323858455;5093.719845408464;5095.2307485580095;5943.375945525658;6040.697965101727;6118.174046503754;6200.658963756947;6211.9689401552705;5790.218320526675;5871.970640146772;5877.911831322448;5906.114082887601;5909.320428150818;6067.696615169136;6070.757169713162;6072.453479186717;6073.544484163617;6077.118817771487;5698.686572238401;5705.7147142643535;5744.942550574441;5753.683547404933;5760.107183386582;5855.238818953509;5856.150858125463;5904.734286957183;5909.261342332208;5955.136505206808;5828.5919985602295;5829.09649004405;5831.475167234969;5831.912521312269;5834.445727655866;5814.709264536672;5819.039858423482;5820.097884827858;5822.446867547576;5828.883422331614;5575.135853942646;5676.091825307931;5710.885782284414;5749.252597162342;5760.884782304247;5825.79609713658;5831.970840145772;5835.387284335084;5842.853928651818;5862.179294898632;5722.084466485342;5724.656520608777;5729.656220626775;5731.283589551306;5734.197212390352 09:29:54 INFO - PROCESS | 15938 | |1;ext.html;548.6013051940615;580.2514755964805;610.2463457629827;624.8344188789971;650.8828410886039;37026.444603330936;49154.50845491544;50077.49922500774;50222.49777502224;50279;51111.74444127774;51705.22442163361;51735.22397164046;51850.740746296215;51928;8635.784105397352;8853.778655533632;9032.77418064547;9264.536773161348;9270.397424167408;10895.564177432892;11210.215284930058;11213.046891014274;11533.308001519894;11534.596289129882;11342.943285283562;11425.314481131118;11426.428678566039;11427.371494567795;11427.600033998811;11339.943300283487;11410.144239182011;11413.201075924688;11420.143489238299;11422;11147.777044459146;11227.775444491064;11234.719132021683;11236.494357753922;11245.381504017276;49044.26433603499;49057;49515.25727114096;49524.75237623789;49584.75207623939;4624.213883639789;4687.929681054787;4707.223308154151;4831.202851529493;4846.39420072491;34179.14552136192;34433;34574.481382779275;34707;36218.094547636254;4554.134714404286;4596.862094137181;4603.125406172817;4614;4644;388063;388518;388948.99999999715;390051;391133;70600.64699676468;71200.28799711936;71393.64303178451;71402.64298678577;71440.64279678569;72231.27768722245;72333.638331808;72397;72411;72442.27557724461;20089.296874609612;20627.17491300361;20744.170233190805;20746.58506829855;20751.481212969797;14448.494302699566;14904.552863414116;14907.403703851724;15370.308336124901;15787.526374208792;18780.497560195152;18969.33607323737;19265.325713600236;19576.412707618794;19868.205271789255;7236.493445458873;7270.600116993511;7275.345218930216;7342.632868356561;7490.4382171337365;1003.6085926488676;1005.2962925951863;1007.8185926533295;1009.2178561614661;1017.9898201018043;33597.49603755945;33902.83048584791;34041.82979085089;34287.971360859214;34598.82700586481;1091.9454027298602;1199.2684462477882;1203.897668698153;1217.3487184356327;1225.748721512088;17573.38493152759;18608.34870779516;18653.533661658566;18685.532861678566;18729;479792;482492;482639;483627;485137;69741;69842.65078674676;69862.30137698558;69878;70072;1510.5770384292416;1538.361579944333;1543.1204213598141;1567.2163918040978;1583.1609247099057;32142.678573214904;33735.15662108369;33864.661353387135;33982.49026264658;34028.69483195174;57640.71179644075;58096.4190358091;58402;58488;58521.70739146277;378843;381759;382798;384002;384476;41994.790026049675;42073.36889946592;44576.77711611551;45228.32157517574;45557;48178.5182148188;48449.27326090182;52825.471745282055;52908.73545632247;53105;40053.1989360217;40878.38682419706;41064;41450;42009.57990420057;40600.39099413452;40683.79658101809;41145.55990540317;42230.78884605557;42353.152936940474;41803.163936720484;42428.36357454579;42735;42769.358459623756;42816;34878.302433951685;36950;36981.81509092437;37312.44031339478;37574.24851503009;26554.601680974414;26655.866720666272;26672.46655066849;26796.732032679425;27175.1847444577 09:29:54 INFO - PROCESS | 15938 | |2;jquery.html;440.57484527431023;440.7950303109054;448.885534188782;448.92817149256126;453.5351264953424;20801;22765.658515122264;22944.77055229447;23074.423139421502;23091;22819.657705134396;22990.770092299073;23260;23295.184668536604;23436.296911092653;5936.614120082191;5952.226210592638;6103.6032657877095;6150.66171360575;6178.660173690445;4669.066186762661;4855.490173531782;6046.697665116749;6094.939050609503;6145.016797312431;6601.339866013408;6900.27547107554;6903.275156108612;7061.435085193198;7074.504784665076;6914.688839002257;6946.895796563055;6976.93023069773;6996.300369962963;7029.7891063267925;6164.137020817089;6189.133521307021;6228.096925945758;6232.470240029603;6238.1266622672865;26386.604200937003;26516.46967060667;26635.20094397171;26655.733442665518;26672.59991100135;2769.8476583787883;2848.430313937221;2891.6819149893495;2906.607607972918;2919.138854038064;11230.55077796887;12037.699057523545;12063.517459301618;13963.232022238773;15248.161351125684;1996.9101390437465;2053.7022131790955;2062.226665000625;2069.5653912678354;2073.1914553324214;100939;102725;102963;104036;104785.99999999924;12261.38693065361;12690.619281421388;13004.674883127998;13155.144915580457;13157.210567365797;18450.723239151423;18532;18533.351332703292;18590.628187436174;18599;9101.954490227507;9105.635774569075;9218.308626853013;9290.442573445614;9310.115539023782;8861.379703420827;8875.556222188994;8927.553622318988;9079.273658107468;9084.636614535477;5440.836774896759;5553.861153471114;5554.527865131509;5576.302962129734;5704.971475142598;1919.606480671459;2105.557832855087;2182.6835108909117;2238.7089678342036;2282.4179834142187;949.2738055387634;953.5613617735919;957.9042095790504;970.9174720148725;981.7054883535054;18952;21324.573508529742;21689.457763556038;21864.781352186594;21888.075183083998;958.8178246133212;973.5424350555228;973.9366941148803;974.3666616699202;978.921686265097;11474.885251147381;11909.583164589198;12137.21108127969;12198.756024879453;12298.20061695987;666743;669333;712232;755712;789285;83007;102060;109764.4511777436;111195;114106.42946785213;1121.147927575049;1152.573547787324;1164.1559869095008;1172.372780562395;1177.7526719388852;18020.36928707489;18700.158492868126;19116.617667646846;19166;19374;43738.56261437472;44214;45654.771726142484;45860.31209531793;47059;65574.67212663907;65859.67070164619;66476.66761666161;66592.33407666055;66600.6669966647;7196.640167991684;9664.323497355117;9717.514124293899;9883.55524001436;10117.19062475015;13756.312184390941;14777.113373197213;15012.924935375253;15139.243037848284;15336.616584585474;12041.157119001586;12165.45255463524;12356.567520136752;12370.567030153901;12863.935680321538;12287.508499659914;12936.547220847226;13154.60536183916;13698.315084245549;13706.725865482835;13168;13238.139520931109;13400.798988015382;13523.323833808467;13782.310884455937;9799.265055120752;9855.605775768889;10033.431524984193;10167.491625418847;10306.587736490756;12077.094217933514;12255;12313.384330783247;12376.504939802307;12879.162854414433 09:29:54 INFO - PROCESS | 15938 | |3;mootools.html;1480.1341215388998;1491.5898128014794;1515.9924200379;1525.5499627609854;1534.716077525657;8066.71766488173;8514.70198543051;8519.1906768857;8520.403571749972;8523.403361764678;7608.125065617455;7845.646945887434;8314;8550.828983420344;8584.828303433927;2474.8886300116537;2517.785988191006;2519.634652975327;2527.747225277476;2531.4683916377585;2510.7740303372693;2549.6430499730054;2560.2319304208754;2563.269468201563;2570.5244529761962;2412.16780210827;2431.6109422492405;2467.5064987002584;2476.2447453526756;2476.925692229236;2361.3034154924426;2377.1917548033666;2379.6668466414544;2385.7256415512093;2400.0879665726998;2387.8925448354867;2412.5054363855365;2414.8068154547595;2462.236706620953;2464.4701389201227;8692.261157801595;8780.078091800333;8789.912100878973;8790.077041910636;8794.384393092487;5342.118550439173;5486.533644640211;5492.038893193675;5492.697901615449;5494.780208791643;3494.0915362006062;3548.6451354864307;3563.875264365761;3595.406757884946;3667.743257971943;1308.2085338370243;1363.6727185475513;1389.9930500347534;1402.4179965314381;1451.804006459125;12080.395980200954;12120.272783632921;12120.878791212062;12159.878401215874;12174.756504869853;4697.7651117444675;4820.084184005028;4867.756612169377;4950.529699678525;4969.254611808257;9458.47978361183;9529.571169297398;9539.666111686058;9540.666076687283;9553.952230238943;5408.486193811582;5431.565474762009;5438.211459338374;5445.346558413015;5454.045542030129;4899.58353539946;5130.871728206825;5199.454057324002;5200.947990520046;5206.869828254324;4031.33719256089;4072.857449989295;4107.404426358161;4118.114605359862;4154.376843473443;1274.4328773695802;1286.8841804237663;1287.2984223597973;1299.3957809618385;1299.4802079168219;963.8843338799389;991.1723710701501;993.4684943555163;999.0808456220295;1000.1198944928417;5767.36558978512;5886.117082437669;5905.143754155709;5905.557083218776;5950.583459157818;631.0754744299624;644.3685188515282;648.2642201101689;655.3446553446554;657.8454063295122;3810.256999884996;4113.03343714227;4128.401381799682;4236.068065025689;4279.272523670983;10034.949825250827;10183.847242291371;10265.178785697126;10320;10521.473926303808;10197.18422526196;10259.487025648688;10306.227032972558;10378.273520853469;10389.480525973822;7900.446968712135;8176.427650064557;8212.055613604392;8212.876806848022;8218.383621228431;5582.637128586629;5656.971715141398;5734.2258795062135;5738.885222295447;5815.505682017076;9416.293777966543;9635.277354198603;9687.806243875224;9747.561359738687;9775.266854985763;9398.20115290208;9745.610175592898;10014.39913605186;10045;10045.347052441568;7270.382017528358;7329.1937886833475;7343.082114735658;7343.4492413068165;7344.30229128232;8338.458000229966;8413.62138703772;8421.19998600132;8426.578671066545;8431.494110353398;7506.699732010877;7570.962145189239;7635.350995165251;7783.610819459118;7796.883046754417;7379.409647228316;7526.661300241392;7539.736109236151;7543.73596924105;7555.433342499225;6854.794356169323;6937.340952609494;7023.824404389727;7028.683709232994;7035.753748618774;4940.92588611164;4987.80048798044;5010.949890501049;5022.096022715946;5220.634555581073;5339.599530035185;5390.595705322038;5443.618946673695;5450.863728406822;5684.261046063985 09:29:54 INFO - PROCESS | 15938 | |4;prototype.html;382.7703377973215;409.75619506393684;411.9985902698839;415.95840415958406;422.0777600941942;5233.816816411427;5324.440933701959;5389.272448219489;5400.83797486075;5461.97906774494;5249.317588713471;5270.683758974465;5280.445553216915;5314.202869569566;5351.779011710136;4240.957590424103;4242.363645453192;4244.681648876347;4262.936055959163;4271.273883439822;4079;4149.481314835645;4207.137536804948;4261.850835220768;4285.764282964436;4216.388623649569;4223.704340696153;4226.556211597784;4238.597333253336;4283.507396649378;4265.594768496988;4280.250956082704;4290.5709429057;4297.59172878576;4298.20483210607;3841.1741475582885;3875.4110814565893;3924.50943632046;3931.1744533647684;3935.960640393617;5226.843194704127;5227.529522342969;5227.738613069369;5241.318628578299;5286.682799032071;4970.627202959792;4985.980677825451;4997.325361076281;5002.624803139779;5024.547790698854;5455.936092461971;5587.7485513152005;5621.915671264935;5681.204631351614;5705.972924873521;4316.438862947828;4337.652987760972;4339.934900976488;4354.521002689701;4379.781010949471;5861.941380586182;5865.472107510302;5877.853053673693;5884.146798714205;5887.175795388606;4032.354823228269;4189.413482112506;4257.148570285955;4466.173757854807;4473.329000649928;4083.9795801020805;4266.978665106717;4273.743575385424;4282.272013757669;4282.507511636201;4728.976355118202;4771.188897887368;4869.6591238612955;4870.318155458239;4871.658983871166;5651;5657.830265092054;5672.546196304285;5702.971485142548;5745.080787074048;1422.8363738170035;1444.2201211345755;1446.5298777897015;1447.9068303430843;1460.167704408477;977.1645243316862;983.6114734679904;985.4284514981293;990.2770977186694;998.4159266828987;5172.55604249477;5328.706921119376;5343.519083282523;5348.518633322942;5438.592105592096;5637.323521177403;5695.202671625976;5699.373068962411;5702.885942281131;5725.914111288334;5349.058018090035;5365.597580181502;5393.83818485446;5416;5452.482014208644;2890.5664150377193;2998.8050776699447;3014.8794048238265;3021.1842802443216;3022.9546556801665;5775.27809023872;5795.884082318415;5846.678432686158;5849.941500585025;5868.237129173265;5544.584156188302;5695.689991302023;5727.336788393417;5748.367679555246;5759.481646651821;5646.632968857093;5664.376918538957;5672.205891175321;5792.739326730307;5797.623154494944;5531;5559.888802223852;5607.5607110906885;5624.718764061862;5635.605507614428;5258.605604579749;5440.809571665131;5514.503694667339;5529.723513824212;5537.5569954404355;5783.479486846204;5796.565257605781;5796.59423840344;5812.3025236971835;5825.679587622722;4027.838886444509;4154.896127596834;4166.979165104155;4168.144820797763;4188.287991041591;5584.337078539465;5607.719614019201;5616;5629.521490673339;5649.802256920988;5479.561635069105;5482.259894914136;5502.257195278587;5521.950829342412;5524.005678977823;5323.349761573924;5407.756650950795;5485.369182543899;5503.917441238465;5538.67375702198;5377.220303056113;5414.404415514212;5447.1829225616475;5455.236266922713;5467.972660136833;5484.287042684426;5503.944960550343;5517.034518959086;5520.696361700145;5552.944470555242;5251.579873610026;5409.648372855751;5581.218629391969;5605.747741351567;5633.521150702072 09:29:54 INFO - PROCESS | 15938 | |5;yui.html;835.2148979958835;856.242225630317;858.974230773077;916.0441124155104;932.598982437552;15791.526254212378;17312.653746925054;17514.036727979958;17540.736888946645;17598.03210823406;15980.200989950485;16142.6278766305;16447.506574802774;16471.258793354296;16597.41909033184;509.28191250337034;520.9583233341342;786.0920636664662;792.2711105782694;792.8374683189961;756.5574139128589;760.8440269744689;766.938644908406;767.8809784483414;769.273036980054;836.0761358698642;837.3803385494721;837.7821766340734;837.9748607541784;838.1534650003509;714.8141483214401;728.5337384074144;833.017039892926;833.6832003838563;833.687367237286;605.9759007277687;613.187526527353;613.6042252746997;615.8460384903774;616.100493279812;16191.028538287741;16715.66568668632;16744;16757.581060473465;16766;14843.183624900626;15203.543893683207;15321.387144514318;15654.9217253913;15705.450309239122;13984.370703318375;14080.92959535206;14107.435702571987;14337.21145337006;14390.640233994129;4536.412255710508;4537.9773101134615;4546.8863278417975;4602.930956035662;4675.228587283094;82926;83034;83510;84929.15070849274;85170.57414712886;11820.522434695664;11834.940825295991;12067.275963442222;12122;12170.208936419105;22447.887760561094;22752.20367287137;22809.087636494354;22811.657825132635;22817.429564260696;8598.527081010605;8631.525266110299;8873.334499912533;8936.731898043068;8997.505137217386;4854.271859221074;4891.26631005352;4891.51084891508;4909.509049095133;5051.772670229849;3720.107174278208;3775.6413140752134;3775.6979441645153;3777.131259810259;3778.3387907116144;633.1578999930082;635.2377147423018;635.9777407790798;638.2213699286955;642.5662677692538;756.9848603027908;764.6116695013196;767.0450289389634;782.1435528096725;789.2659826361539;10541.947290263499;10692.572297108029;10948.288361256493;11734.151694822678;12159.817602735966;680.9080774095532;704.3731079339392;711.8256027273351;736.1791602363327;810.0967421325298;5163.896722065538;5507.129766215231;5658;5659.43405659439;5690.829275121753;60423;60564.091538626955;61353;66252;73899;63874;66491;66598.66700666562;67166.66416667885;67185.66407167933;58991.41008589945;59124.99999999914;59801;60169.69915150396;60403.69798150981;10727.731806704895;10911.181661375269;11069.514208785482;11214.66356009321;11314.264572802742;37649.24701506009;38253.234935300585;40560;41147;42821.78589107034;48868;50713.746431269086;50843.983120338125;51995;53934;14298.142111473346;14333.426662933365;14388.136711797326;14394;14570.781438278646;15916.761248581512;15999.440019599258;16269.186540673156;16321.836781632506;16413.67172656564;15086.849131508545;15200.391984320504;15211.543653690407;15220.771688424904;15273.312700928707;14233.715325693222;14323.57029289123;14644.267786610413;15000.549983500512;15282.847171528587;14588.708225835211;14741.484048058266;14770.34013200081;14891.25543722788;15245.771313430529;11726.41367931617;12025.819612705991;12207;12518;12526.185797923106;11685.883141168479;11744.882551174378;11835.763284734428;11914.52341906314;12068.396580171131 09:29:54 INFO - PROCESS | 15938 | __end_tp_report 09:29:54 INFO - PROCESS | 15938 | __start_cc_report 09:29:54 INFO - PROCESS | 15938 | _x_x_mozilla_cycle_collect,932 09:29:54 INFO - PROCESS | 15938 | __end_cc_report 09:29:54 INFO - PROCESS | 15938 | __startTimestamp1485192594255__endTimestamp 09:29:54 INFO - PROCESS | 15938 | 09:29:54 INFO - PROCESS | 15938 | ------- Summary: start ------- 09:29:54 INFO - PROCESS | 15938 | Number of tests: 6 09:29:54 INFO - PROCESS | 15938 | 09:29:54 INFO - PROCESS | 15938 | [#0] dojo.html Cycles:165 Average:5488.65 Median:5753.68 stddev:614.41 (10.7%) stddev-sans-first:591.42 09:29:54 INFO - PROCESS | 15938 | Values: 3282.5 3322.4 3322.5 3349.5 3368.7 5506.6 5589.0 5596.5 5608.3 5619.4 5489.4 5518.4 5550.3 5565.8 5588.9 4885.4 4936.9 4972.6 5008.8 5009.8 4877.9 4897.6 4976.5 5017.7 5025.9 4838.5 4868.6 4918.5 4949.0 4974.9 4971.6 4974.1 4987.1 4987.2 5010.1 4805.6 4913.1 4933.5 4946.7 4974.1 5340.0 5378.5 5477.2 5483.1 5539.3 5929.5 5938.1 5942.0 5942.2 5944.1 5926.3 5969.5 5977.0 5988.9 5989.6 5432.6 5455.0 5471.3 5502.8 5518.0 6033.8 6034.3 6035.5 6037.2 6071.5 5761.3 5796.1 5798.8 5805.5 5806.7 5756.8 5805.5 5834.0 5850.7 5910.6 5887.4 5938.7 5942.7 5957.4 5976.1 5879.8 5888.7 5889.7 5889.9 5895.7 4462.6 4492.1 4522.8 4576.5 4583.1 4049.8 4071.1 4093.8 4099.8 4113.5 5764.4 5767.7 5768.5 5769.8 5776.0 5766.6 5861.4 5891.5 5932.6 5999.9 5648.2 5651.9 5657.5 5659.6 5671.5 5083.7 5092.3 5093.0 5093.7 5095.2 5943.4 6040.7 6118.2 6200.7 6212.0 5790.2 5872.0 5877.9 5906.1 5909.3 6067.7 6070.8 6072.5 6073.5 6077.1 5698.7 5705.7 5744.9 5753.7 5760.1 5855.2 5856.2 5904.7 5909.3 5955.1 5828.6 5829.1 5831.5 5831.9 5834.4 5814.7 5819.0 5820.1 5822.4 5828.9 5575.1 5676.1 5710.9 5749.3 5760.9 5825.8 5832.0 5835.4 5842.9 5862.2 5722.1 5724.7 5729.7 5731.3 5734.2 09:29:54 INFO - PROCESS | 15938 | 09:29:54 INFO - PROCESS | 15938 | [#1] ext.html Cycles:180 Average:61366.66 Median:215593.10 stddev:110687.45 (51.3%) stddev-sans-first:110903.77 09:29:54 INFO - PROCESS | 15938 | Values: 548.6 580.3 610.2 624.8 650.9 37026.4 49154.5 50077.5 50222.5 50279.0 51111.7 51705.2 51735.2 51850.7 51928.0 8635.8 8853.8 9032.8 9264.5 9270.4 10895.6 11210.2 11213.0 11533.3 11534.6 11342.9 11425.3 11426.4 11427.4 11427.6 11339.9 11410.1 11413.2 11420.1 11422.0 11147.8 11227.8 11234.7 11236.5 11245.4 49044.3 49057.0 49515.3 49524.8 49584.8 4624.2 4687.9 4707.2 4831.2 4846.4 34179.1 34433.0 34574.5 34707.0 36218.1 4554.1 4596.9 4603.1 4614.0 4644.0 388063.0 388518.0 388949.0 390051.0 391133.0 70600.6 71200.3 71393.6 71402.6 71440.6 72231.3 72333.6 72397.0 72411.0 72442.3 20089.3 20627.2 20744.2 20746.6 20751.5 14448.5 14904.6 14907.4 15370.3 15787.5 18780.5 18969.3 19265.3 19576.4 19868.2 7236.5 7270.6 7275.3 7342.6 7490.4 1003.6 1005.3 1007.8 1009.2 1018.0 33597.5 33902.8 34041.8 34288.0 34598.8 1091.9 1199.3 1203.9 1217.3 1225.7 17573.4 18608.3 18653.5 18685.5 18729.0 479792.0 482492.0 482639.0 483627.0 485137.0 69741.0 69842.7 69862.3 69878.0 70072.0 1510.6 1538.4 1543.1 1567.2 1583.2 32142.7 33735.2 33864.7 33982.5 34028.7 57640.7 58096.4 58402.0 58488.0 58521.7 378843.0 381759.0 382798.0 384002.0 384476.0 41994.8 42073.4 44576.8 45228.3 45557.0 48178.5 48449.3 52825.5 52908.7 53105.0 40053.2 40878.4 41064.0 41450.0 42009.6 40600.4 40683.8 41145.6 42230.8 42353.2 41803.2 42428.4 42735.0 42769.4 42816.0 34878.3 36950.0 36981.8 37312.4 37574.2 26554.6 26655.9 26672.5 26796.7 27175.2 09:29:54 INFO - PROCESS | 15938 | 09:29:54 INFO - PROCESS | 15938 | [#2] jquery.html Cycles:180 Average:37706.36 Median:23277.59 stddev:118236.36 (507.9%) stddev-sans-first:118534.93 09:29:54 INFO - PROCESS | 15938 | Values: 440.6 440.8 448.9 448.9 453.5 20801.0 22765.7 22944.8 23074.4 23091.0 22819.7 22990.8 23260.0 23295.2 23436.3 5936.6 5952.2 6103.6 6150.7 6178.7 4669.1 4855.5 6046.7 6094.9 6145.0 6601.3 6900.3 6903.3 7061.4 7074.5 6914.7 6946.9 6976.9 6996.3 7029.8 6164.1 6189.1 6228.1 6232.5 6238.1 26386.6 26516.5 26635.2 26655.7 26672.6 2769.8 2848.4 2891.7 2906.6 2919.1 11230.6 12037.7 12063.5 13963.2 15248.2 1996.9 2053.7 2062.2 2069.6 2073.2 100939.0 102725.0 102963.0 104036.0 104786.0 12261.4 12690.6 13004.7 13155.1 13157.2 18450.7 18532.0 18533.4 18590.6 18599.0 9102.0 9105.6 9218.3 9290.4 9310.1 8861.4 8875.6 8927.6 9079.3 9084.6 5440.8 5553.9 5554.5 5576.3 5705.0 1919.6 2105.6 2182.7 2238.7 2282.4 949.3 953.6 957.9 970.9 981.7 18952.0 21324.6 21689.5 21864.8 21888.1 958.8 973.5 973.9 974.4 978.9 11474.9 11909.6 12137.2 12198.8 12298.2 666743.0 669333.0 712232.0 755712.0 789285.0 83007.0 102060.0 109764.5 111195.0 114106.4 1121.1 1152.6 1164.2 1172.4 1177.8 18020.4 18700.2 19116.6 19166.0 19374.0 43738.6 44214.0 45654.8 45860.3 47059.0 65574.7 65859.7 66476.7 66592.3 66600.7 7196.6 9664.3 9717.5 9883.6 10117.2 13756.3 14777.1 15012.9 15139.2 15336.6 12041.2 12165.5 12356.6 12370.6 12863.9 12287.5 12936.5 13154.6 13698.3 13706.7 13168.0 13238.1 13400.8 13523.3 13782.3 9799.3 9855.6 10033.4 10167.5 10306.6 12077.1 12255.0 12313.4 12376.5 12879.2 09:29:54 INFO - PROCESS | 15938 | 09:29:54 INFO - PROCESS | 15938 | [#3] mootools.html Cycles:180 Average:5723.10 Median:5366.36 stddev:3108.80 (57.9%) stddev-sans-first:3101.16 09:29:54 INFO - PROCESS | 15938 | Values: 1480.1 1491.6 1516.0 1525.5 1534.7 8066.7 8514.7 8519.2 8520.4 8523.4 7608.1 7845.6 8314.0 8550.8 8584.8 2474.9 2517.8 2519.6 2527.7 2531.5 2510.8 2549.6 2560.2 2563.3 2570.5 2412.2 2431.6 2467.5 2476.2 2476.9 2361.3 2377.2 2379.7 2385.7 2400.1 2387.9 2412.5 2414.8 2462.2 2464.5 8692.3 8780.1 8789.9 8790.1 8794.4 5342.1 5486.5 5492.0 5492.7 5494.8 3494.1 3548.6 3563.9 3595.4 3667.7 1308.2 1363.7 1390.0 1402.4 1451.8 12080.4 12120.3 12120.9 12159.9 12174.8 4697.8 4820.1 4867.8 4950.5 4969.3 9458.5 9529.6 9539.7 9540.7 9554.0 5408.5 5431.6 5438.2 5445.3 5454.0 4899.6 5130.9 5199.5 5200.9 5206.9 4031.3 4072.9 4107.4 4118.1 4154.4 1274.4 1286.9 1287.3 1299.4 1299.5 963.9 991.2 993.5 999.1 1000.1 5767.4 5886.1 5905.1 5905.6 5950.6 631.1 644.4 648.3 655.3 657.8 3810.3 4113.0 4128.4 4236.1 4279.3 10034.9 10183.8 10265.2 10320.0 10521.5 10197.2 10259.5 10306.2 10378.3 10389.5 7900.4 8176.4 8212.1 8212.9 8218.4 5582.6 5657.0 5734.2 5738.9 5815.5 9416.3 9635.3 9687.8 9747.6 9775.3 9398.2 9745.6 10014.4 10045.0 10045.3 7270.4 7329.2 7343.1 7343.4 7344.3 8338.5 8413.6 8421.2 8426.6 8431.5 7506.7 7571.0 7635.4 7783.6 7796.9 7379.4 7526.7 7539.7 7543.7 7555.4 6854.8 6937.3 7023.8 7028.7 7035.8 4940.9 4987.8 5010.9 5022.1 5220.6 5339.6 5390.6 5443.6 5450.9 5684.3 09:29:54 INFO - PROCESS | 15938 | 09:29:54 INFO - PROCESS | 15938 | [#4] prototype.html Cycles:180 Average:4725.51 Median:5371.41 stddev:1338.39 (24.9%) stddev-sans-first:1301.85 09:29:54 INFO - PROCESS | 15938 | Values: 382.8 409.8 412.0 416.0 422.1 5233.8 5324.4 5389.3 5400.8 5462.0 5249.3 5270.7 5280.4 5314.2 5351.8 4241.0 4242.4 4244.7 4262.9 4271.3 4079.0 4149.5 4207.1 4261.9 4285.8 4216.4 4223.7 4226.6 4238.6 4283.5 4265.6 4280.3 4290.6 4297.6 4298.2 3841.2 3875.4 3924.5 3931.2 3936.0 5226.8 5227.5 5227.7 5241.3 5286.7 4970.6 4986.0 4997.3 5002.6 5024.5 5455.9 5587.7 5621.9 5681.2 5706.0 4316.4 4337.7 4339.9 4354.5 4379.8 5861.9 5865.5 5877.9 5884.1 5887.2 4032.4 4189.4 4257.1 4466.2 4473.3 4084.0 4267.0 4273.7 4282.3 4282.5 4729.0 4771.2 4869.7 4870.3 4871.7 5651.0 5657.8 5672.5 5703.0 5745.1 1422.8 1444.2 1446.5 1447.9 1460.2 977.2 983.6 985.4 990.3 998.4 5172.6 5328.7 5343.5 5348.5 5438.6 5637.3 5695.2 5699.4 5702.9 5725.9 5349.1 5365.6 5393.8 5416.0 5452.5 2890.6 2998.8 3014.9 3021.2 3023.0 5775.3 5795.9 5846.7 5849.9 5868.2 5544.6 5695.7 5727.3 5748.4 5759.5 5646.6 5664.4 5672.2 5792.7 5797.6 5531.0 5559.9 5607.6 5624.7 5635.6 5258.6 5440.8 5514.5 5529.7 5537.6 5783.5 5796.6 5796.6 5812.3 5825.7 4027.8 4154.9 4167.0 4168.1 4188.3 5584.3 5607.7 5616.0 5629.5 5649.8 5479.6 5482.3 5502.3 5522.0 5524.0 5323.3 5407.8 5485.4 5503.9 5538.7 5377.2 5414.4 5447.2 5455.2 5468.0 5484.3 5503.9 5517.0 5520.7 5552.9 5251.6 5409.6 5581.2 5605.7 5633.5 09:29:54 INFO - PROCESS | 15938 | 09:29:54 INFO - PROCESS | 15938 | [#5] yui.html Cycles:180 Average:17668.01 Median:4537.19 stddev:21122.59 (465.5%) stddev-sans-first:21144.02 09:29:54 INFO - PROCESS | 15938 | Values: 835.2 856.2 859.0 916.0 932.6 15791.5 17312.7 17514.0 17540.7 17598.0 15980.2 16142.6 16447.5 16471.3 16597.4 509.3 521.0 786.1 792.3 792.8 756.6 760.8 766.9 767.9 769.3 836.1 837.4 837.8 838.0 838.2 714.8 728.5 833.0 833.7 833.7 606.0 613.2 613.6 615.8 616.1 16191.0 16715.7 16744.0 16757.6 16766.0 14843.2 15203.5 15321.4 15654.9 15705.5 13984.4 14080.9 14107.4 14337.2 14390.6 4536.4 4538.0 4546.9 4602.9 4675.2 82926.0 83034.0 83510.0 84929.2 85170.6 11820.5 11834.9 12067.3 12122.0 12170.2 22447.9 22752.2 22809.1 22811.7 22817.4 8598.5 8631.5 8873.3 8936.7 8997.5 4854.3 4891.3 4891.5 4909.5 5051.8 3720.1 3775.6 3775.7 3777.1 3778.3 633.2 635.2 636.0 638.2 642.6 757.0 764.6 767.0 782.1 789.3 10541.9 10692.6 10948.3 11734.2 12159.8 680.9 704.4 711.8 736.2 810.1 5163.9 5507.1 5658.0 5659.4 5690.8 60423.0 60564.1 61353.0 66252.0 73899.0 63874.0 66491.0 66598.7 67166.7 67185.7 58991.4 59125.0 59801.0 60169.7 60403.7 10727.7 10911.2 11069.5 11214.7 11314.3 37649.2 38253.2 40560.0 41147.0 42821.8 48868.0 50713.7 50844.0 51995.0 53934.0 14298.1 14333.4 14388.1 14394.0 14570.8 15916.8 15999.4 16269.2 16321.8 16413.7 15086.8 15200.4 15211.5 15220.8 15273.3 14233.7 14323.6 14644.3 15000.5 15282.8 14588.7 14741.5 14770.3 14891.3 15245.8 11726.4 12025.8 12207.0 12518.0 12526.2 11685.9 11744.9 11835.8 11914.5 12068.4 09:29:54 INFO - PROCESS | 15938 | -------- Summary: end -------- 09:29:54 INFO - PROCESS | 15938 | 09:29:54 INFO - TEST-INFO | 15938: exit 0 09:29:54 INFO - TEST-OK | dromaeo_css | took 1113042ms 09:29:54 INFO - TEST-START | kraken 09:29:54 INFO - operating with platform_type : linux_ 09:29:54 INFO - Initialising browser for kraken test... 09:29:54 INFO - TEST-INFO | started process 16260 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiSJpKe/profile http://localhost:57065/getInfo.html) 09:29:58 INFO - PROCESS | 16260 | __metrics Screen width/height:1600/1200 09:29:58 INFO - PROCESS | 16260 | colorDepth:24 09:29:58 INFO - PROCESS | 16260 | Browser inner width/height: 1024/697 09:29:58 INFO - PROCESS | 16260 | __metrics 09:29:59 INFO - PROCESS | 16260 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 09:29:59 INFO - PROCESS | 16260 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:29:59 INFO - PROCESS | 16260 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:29:59 INFO - PROCESS | 16260 | console.error: PushService: 09:29:59 INFO - PROCESS | 16260 | stateChangeProcessEnqueue: Error transitioning state 09:29:59 INFO - PROCESS | 16260 | UnknownError 09:30:00 INFO - TEST-INFO | 16260: exit 0 09:30:00 INFO - Browser initialized. 09:30:00 INFO - Running cycle 1/1 for kraken test... 09:30:00 INFO - TEST-INFO | started process 16353 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiSJpKe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:30:12 INFO - PROCESS | 16353 | RSS: Main: 138190848 09:30:12 INFO - PROCESS | 16353 | 09:30:14 INFO - PROCESS | 16353 | Cycle 1(1): loaded http://localhost:57065/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57065/tests/kraken/driver.html?testName=audio-beat-detection) 09:30:15 INFO - PROCESS | 16353 | RSS: Main: 182480896 09:30:15 INFO - PROCESS | 16353 | 09:30:17 INFO - PROCESS | 16353 | Cycle 1(1): loaded http://localhost:57065/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57065/tests/kraken/driver.html?testName=audio-dft) 09:30:18 INFO - PROCESS | 16353 | RSS: Main: 172466176 09:30:18 INFO - PROCESS | 16353 | 09:30:21 INFO - PROCESS | 16353 | Cycle 1(1): loaded http://localhost:57065/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57065/tests/kraken/driver.html?testName=audio-fft) 09:30:21 INFO - PROCESS | 16353 | RSS: Main: 263749632 09:30:21 INFO - PROCESS | 16353 | 09:30:23 INFO - PROCESS | 16353 | Cycle 1(1): loaded http://localhost:57065/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57065/tests/kraken/driver.html?testName=audio-oscillator) 09:30:24 INFO - PROCESS | 16353 | RSS: Main: 169754624 09:30:24 INFO - PROCESS | 16353 | 09:30:26 INFO - PROCESS | 16353 | Cycle 1(1): loaded http://localhost:57065/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57065/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:30:27 INFO - PROCESS | 16353 | RSS: Main: 172797952 09:30:27 INFO - PROCESS | 16353 | 09:30:30 INFO - PROCESS | 16353 | Cycle 1(1): loaded http://localhost:57065/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57065/tests/kraken/driver.html?testName=imaging-darkroom) 09:30:30 INFO - PROCESS | 16353 | RSS: Main: 211447808 09:30:30 INFO - PROCESS | 16353 | 09:30:34 INFO - PROCESS | 16353 | Cycle 1(1): loaded http://localhost:57065/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57065/tests/kraken/driver.html?testName=imaging-desaturate) 09:30:34 INFO - PROCESS | 16353 | RSS: Main: 210411520 09:30:34 INFO - PROCESS | 16353 | 09:30:37 INFO - PROCESS | 16353 | Cycle 1(1): loaded http://localhost:57065/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57065/tests/kraken/driver.html?testName=json-parse-financial) 09:30:37 INFO - PROCESS | 16353 | RSS: Main: 208506880 09:30:37 INFO - PROCESS | 16353 | 09:30:39 INFO - PROCESS | 16353 | Cycle 1(1): loaded http://localhost:57065/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57065/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:30:40 INFO - PROCESS | 16353 | RSS: Main: 171077632 09:30:40 INFO - PROCESS | 16353 | 09:30:41 INFO - PROCESS | 16353 | Cycle 1(1): loaded http://localhost:57065/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57065/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:30:42 INFO - PROCESS | 16353 | RSS: Main: 177782784 09:30:42 INFO - PROCESS | 16353 | 09:30:44 INFO - PROCESS | 16353 | Cycle 1(1): loaded http://localhost:57065/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57065/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:30:44 INFO - PROCESS | 16353 | RSS: Main: 186851328 09:30:44 INFO - PROCESS | 16353 | 09:30:47 INFO - PROCESS | 16353 | Cycle 1(1): loaded http://localhost:57065/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:30:48 INFO - PROCESS | 16353 | RSS: Main: 195993600 09:30:48 INFO - PROCESS | 16353 | 09:30:50 INFO - PROCESS | 16353 | Cycle 1(1): loaded http://localhost:57065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:30:51 INFO - PROCESS | 16353 | RSS: Main: 192716800 09:30:51 INFO - PROCESS | 16353 | 09:30:53 INFO - PROCESS | 16353 | Cycle 1(1): loaded http://localhost:57065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57065/tests/kraken/driver.html?testName=ai-astar) 09:30:53 INFO - PROCESS | 16353 | RSS: Main: 244727808 09:30:53 INFO - PROCESS | 16353 | 09:30:53 INFO - PROCESS | 16353 | __start_tp_report 09:30:53 INFO - PROCESS | 16353 | _x_x_mozilla_page_load 09:30:53 INFO - PROCESS | 16353 | _x_x_mozilla_page_load_details 09:30:53 INFO - PROCESS | 16353 | |i|pagename|runs| 09:30:53 INFO - PROCESS | 16353 | |0;ai-astar;120;110;111;111;110;111;110;110;110;110 09:30:53 INFO - PROCESS | 16353 | |1;audio-beat-detection;143;117;123;154;123;118;117;117;136;118 09:30:53 INFO - PROCESS | 16353 | |2;audio-dft;161;162;160;160;163;160;160;161;160;161 09:30:53 INFO - PROCESS | 16353 | |3;audio-fft;75;75;75;116;76;75;75;75;89;75 09:30:53 INFO - PROCESS | 16353 | |4;audio-oscillator;83;83;98;83;82;83;95;83;82;99 09:30:53 INFO - PROCESS | 16353 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 09:30:53 INFO - PROCESS | 16353 | |6;imaging-darkroom;147;146;147;146;147;146;146;146;146;148 09:30:53 INFO - PROCESS | 16353 | |7;imaging-desaturate;95;96;96;96;96;96;96;96;96;96 09:30:53 INFO - PROCESS | 16353 | |8;json-parse-financial;50;49;48;48;48;48;48;49;49;50 09:30:53 INFO - PROCESS | 16353 | |9;json-stringify-tinderbox;64;64;64;63;64;64;63;63;64;64 09:30:53 INFO - PROCESS | 16353 | |10;stanford-crypto-aes;77;83;77;76;76;85;77;75;74;76 09:30:53 INFO - PROCESS | 16353 | |11;stanford-crypto-ccm;131;121;120;123;122;119;131;119;161;127 09:30:53 INFO - PROCESS | 16353 | |12;stanford-crypto-pbkdf2;157;157;160;158;160;161;159;163;165;157 09:30:53 INFO - PROCESS | 16353 | |13;stanford-crypto-sha256-iterative;60;60;60;59;63;62;60;58;60;59 09:30:53 INFO - PROCESS | 16353 | __end_tp_report 09:30:53 INFO - PROCESS | 16353 | __start_cc_report 09:30:53 INFO - PROCESS | 16353 | _x_x_mozilla_cycle_collect,1544 09:30:53 INFO - PROCESS | 16353 | __end_cc_report 09:30:53 INFO - PROCESS | 16353 | __startTimestamp1485192653385__endTimestamp 09:30:53 INFO - PROCESS | 16353 | 09:30:53 INFO - PROCESS | 16353 | ------- Summary: start ------- 09:30:53 INFO - PROCESS | 16353 | Number of tests: 14 09:30:53 INFO - PROCESS | 16353 | 09:30:53 INFO - PROCESS | 16353 | [#0] ai-astar Cycles:10 Average:111.30 Median:110.50 stddev:3.09 (2.8%) stddev-sans-first:0.50 09:30:53 INFO - PROCESS | 16353 | Values: 120.0 110.0 111.0 111.0 110.0 111.0 110.0 110.0 110.0 110.0 09:30:53 INFO - PROCESS | 16353 | 09:30:53 INFO - PROCESS | 16353 | [#1] audio-beat-detection Cycles:10 Average:126.60 Median:123.00 stddev:13.16 (10.7%) stddev-sans-first:12.55 09:30:53 INFO - PROCESS | 16353 | Values: 143.0 117.0 123.0 154.0 123.0 118.0 117.0 117.0 136.0 118.0 09:30:53 INFO - PROCESS | 16353 | 09:30:53 INFO - PROCESS | 16353 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 09:30:53 INFO - PROCESS | 16353 | Values: 161.0 162.0 160.0 160.0 163.0 160.0 160.0 161.0 160.0 161.0 09:30:53 INFO - PROCESS | 16353 | 09:30:53 INFO - PROCESS | 16353 | [#3] audio-fft Cycles:10 Average:80.60 Median:75.00 stddev:13.18 (17.6%) stddev-sans-first:13.83 09:30:53 INFO - PROCESS | 16353 | Values: 75.0 75.0 75.0 116.0 76.0 75.0 75.0 75.0 89.0 75.0 09:30:53 INFO - PROCESS | 16353 | 09:30:53 INFO - PROCESS | 16353 | [#4] audio-oscillator Cycles:10 Average:87.10 Median:83.00 stddev:7.14 (8.6%) stddev-sans-first:7.42 09:30:53 INFO - PROCESS | 16353 | Values: 83.0 83.0 98.0 83.0 82.0 83.0 95.0 83.0 82.0 99.0 09:30:53 INFO - PROCESS | 16353 | 09:30:53 INFO - PROCESS | 16353 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 09:30:53 INFO - PROCESS | 16353 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 09:30:53 INFO - PROCESS | 16353 | 09:30:53 INFO - PROCESS | 16353 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 09:30:53 INFO - PROCESS | 16353 | Values: 147.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 148.0 09:30:53 INFO - PROCESS | 16353 | 09:30:53 INFO - PROCESS | 16353 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 09:30:53 INFO - PROCESS | 16353 | Values: 95.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 09:30:53 INFO - PROCESS | 16353 | 09:30:53 INFO - PROCESS | 16353 | [#8] json-parse-financial Cycles:10 Average:48.70 Median:49.00 stddev:0.82 (1.7%) stddev-sans-first:0.73 09:30:53 INFO - PROCESS | 16353 | Values: 50.0 49.0 48.0 48.0 48.0 48.0 48.0 49.0 49.0 50.0 09:30:53 INFO - PROCESS | 16353 | 09:30:53 INFO - PROCESS | 16353 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 09:30:53 INFO - PROCESS | 16353 | Values: 64.0 64.0 64.0 63.0 64.0 64.0 63.0 63.0 64.0 64.0 09:30:53 INFO - PROCESS | 16353 | 09:30:53 INFO - PROCESS | 16353 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:77.00 stddev:3.53 (4.6%) stddev-sans-first:3.74 09:30:53 INFO - PROCESS | 16353 | Values: 77.0 83.0 77.0 76.0 76.0 85.0 77.0 75.0 74.0 76.0 09:30:53 INFO - PROCESS | 16353 | 09:30:53 INFO - PROCESS | 16353 | [#11] stanford-crypto-ccm Cycles:10 Average:127.40 Median:125.00 stddev:12.65 (10.1%) stddev-sans-first:13.35 09:30:53 INFO - PROCESS | 16353 | Values: 131.0 121.0 120.0 123.0 122.0 119.0 131.0 119.0 161.0 127.0 09:30:53 INFO - PROCESS | 16353 | 09:30:53 INFO - PROCESS | 16353 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.70 Median:160.00 stddev:2.71 (1.7%) stddev-sans-first:2.69 09:30:53 INFO - PROCESS | 16353 | Values: 157.0 157.0 160.0 158.0 160.0 161.0 159.0 163.0 165.0 157.0 09:30:53 INFO - PROCESS | 16353 | 09:30:53 INFO - PROCESS | 16353 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.10 Median:60.00 stddev:1.45 (2.4%) stddev-sans-first:1.54 09:30:53 INFO - PROCESS | 16353 | Values: 60.0 60.0 60.0 59.0 63.0 62.0 60.0 58.0 60.0 59.0 09:30:53 INFO - PROCESS | 16353 | -------- Summary: end -------- 09:30:53 INFO - PROCESS | 16353 | 09:30:54 INFO - TEST-INFO | 16353: exit 0 09:30:54 INFO - TEST-OK | kraken | took 59520ms 09:30:54 INFO - SUITE-END | took 1172s 09:30:54 INFO - Completed test suite (00:19:32) 09:30:54 INFO - javascript benchmark 09:30:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3282.4748040313552, 3322.4351860183765, 3322.45179545375, 3349.4808304712747, 3368.713659338956, 5506.5870059745475, 5589.049861523541, 5596.468335508121, 5608.270924779783, 5619.381867994517, 5489.3961664217, 5518.365387980383, 5550.306211723535, 5565.777368905249, 5588.86027849303, 4885.413750349954, 4936.901261974758, 4972.602191824645, 5008.7996480140755, 5009.824656137036, 4877.926831097537, 4897.583705385029, 4976.4525902150735, 5017.69893806371, 5025.924611130836, 4838.540338667821, 4868.634852386085, 4918.458969513351, 4948.950510494885, 4974.900501989958, 4971.602271818246, 4974.1295273327205, 4987.0524600325825, 4987.177115775893, 5010.0981823271795, 4805.591524720368, 4913.140200464904, 4933.481984391623, 4946.678465899741, 4974.129527332739, 5339.9733001335135, 5378.46215378463, 5477.178423236506, 5483.067878460672, 5539.25220095286, 5929.466348028655, 5938.138969849391, 5941.970290148565, 5942.197803296543, 5944.078667806497, 5926.348101708809, 5969.522438204976, 5977.043673012297, 5988.880222395528, 5989.610675306091, 5432.6468779529205, 5454.972725136349, 5471.261379713767, 5502.80740174092, 5518.0, 6033.758649653964, 6034.336223015464, 6035.547333949971, 6037.184980027728, 6071.51427885768, 5761.279840019997, 5796.1305804129715, 5798.82603521895, 5805.535557155502, 5806.65160090396, 5756.769729210869, 5805.477507024388, 5833.970830145822, 5850.707464626752, 5910.556708246899, 5887.411258874078, 5938.673372964528, 5942.673152976541, 5957.434043765836, 5976.133460648269, 5879.794207202727, 5888.735006924699, 5889.705514724246, 5889.852753681193, 5895.7052147393315, 4462.642988560908, 4492.124035813051, 4522.773861306921, 4576.4508259009135, 4583.106294272585, 4049.8380064797666, 4071.0840060986043, 4093.795310234536, 4099.8360065597635, 4113.465249517543, 5764.394738552475, 5767.711614419262, 5768.538516918637, 5769.826905192851, 5775.971120144456, 5766.5675074368755, 5861.443162899603, 5891.499222566044, 5932.644041357532, 5999.910001349983, 5648.237487939158, 5651.9152212716845, 5657.547396208293, 5659.5755318351285, 5671.546276297886, 5083.669561478492, 5092.287079808756, 5093.032323858455, 5093.719845408464, 5095.2307485580095, 5943.375945525658, 6040.697965101727, 6118.174046503754, 6200.658963756947, 6211.9689401552705, 5790.218320526675, 5871.970640146772, 5877.911831322448, 5906.114082887601, 5909.320428150818, 6067.696615169136, 6070.757169713162, 6072.453479186717, 6073.544484163617, 6077.118817771487, 5698.686572238401, 5705.7147142643535, 5744.942550574441, 5753.683547404933, 5760.107183386582, 5855.238818953509, 5856.150858125463, 5904.734286957183, 5909.261342332208, 5955.136505206808, 5828.5919985602295, 5829.09649004405, 5831.475167234969, 5831.912521312269, 5834.445727655866, 5814.709264536672, 5819.039858423482, 5820.097884827858, 5822.446867547576, 5828.883422331614, 5575.135853942646, 5676.091825307931, 5710.885782284414, 5749.252597162342, 5760.884782304247, 5825.79609713658, 5831.970840145772, 5835.387284335084, 5842.853928651818, 5862.179294898632, 5722.084466485342, 5724.656520608777, 5729.656220626775, 5731.283589551306, 5734.197212390352], "value": 5448.570569661101, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [548.6013051940615, 580.2514755964805, 610.2463457629827, 624.8344188789971, 650.8828410886039, 37026.444603330936, 49154.50845491544, 50077.49922500774, 50222.49777502224, 50279.0, 51111.74444127774, 51705.22442163361, 51735.22397164046, 51850.740746296215, 51928.0, 8635.784105397352, 8853.778655533632, 9032.77418064547, 9264.536773161348, 9270.397424167408, 10895.564177432892, 11210.215284930058, 11213.046891014274, 11533.308001519894, 11534.596289129882, 11342.943285283562, 11425.314481131118, 11426.428678566039, 11427.371494567795, 11427.600033998811, 11339.943300283487, 11410.144239182011, 11413.201075924688, 11420.143489238299, 11422.0, 11147.777044459146, 11227.775444491064, 11234.719132021683, 11236.494357753922, 11245.381504017276, 49044.26433603499, 49057.0, 49515.25727114096, 49524.75237623789, 49584.75207623939, 4624.213883639789, 4687.929681054787, 4707.223308154151, 4831.202851529493, 4846.39420072491, 34179.14552136192, 34433.0, 34574.481382779275, 34707.0, 36218.094547636254, 4554.134714404286, 4596.862094137181, 4603.125406172817, 4614.0, 4644.0, 388063.0, 388518.0, 388948.99999999715, 390051.0, 391133.0, 70600.64699676468, 71200.28799711936, 71393.64303178451, 71402.64298678577, 71440.64279678569, 72231.27768722245, 72333.638331808, 72397.0, 72411.0, 72442.27557724461, 20089.296874609612, 20627.17491300361, 20744.170233190805, 20746.58506829855, 20751.481212969797, 14448.494302699566, 14904.552863414116, 14907.403703851724, 15370.308336124901, 15787.526374208792, 18780.497560195152, 18969.33607323737, 19265.325713600236, 19576.412707618794, 19868.205271789255, 7236.493445458873, 7270.600116993511, 7275.345218930216, 7342.632868356561, 7490.4382171337365, 1003.6085926488676, 1005.2962925951863, 1007.8185926533295, 1009.2178561614661, 1017.9898201018043, 33597.49603755945, 33902.83048584791, 34041.82979085089, 34287.971360859214, 34598.82700586481, 1091.9454027298602, 1199.2684462477882, 1203.897668698153, 1217.3487184356327, 1225.748721512088, 17573.38493152759, 18608.34870779516, 18653.533661658566, 18685.532861678566, 18729.0, 479792.0, 482492.0, 482639.0, 483627.0, 485137.0, 69741.0, 69842.65078674676, 69862.30137698558, 69878.0, 70072.0, 1510.5770384292416, 1538.361579944333, 1543.1204213598141, 1567.2163918040978, 1583.1609247099057, 32142.678573214904, 33735.15662108369, 33864.661353387135, 33982.49026264658, 34028.69483195174, 57640.71179644075, 58096.4190358091, 58402.0, 58488.0, 58521.70739146277, 378843.0, 381759.0, 382798.0, 384002.0, 384476.0, 41994.790026049675, 42073.36889946592, 44576.77711611551, 45228.32157517574, 45557.0, 48178.5182148188, 48449.27326090182, 52825.471745282055, 52908.73545632247, 53105.0, 40053.1989360217, 40878.38682419706, 41064.0, 41450.0, 42009.57990420057, 40600.39099413452, 40683.79658101809, 41145.55990540317, 42230.78884605557, 42353.152936940474, 41803.163936720484, 42428.36357454579, 42735.0, 42769.358459623756, 42816.0, 34878.302433951685, 36950.0, 36981.81509092437, 37312.44031339478, 37574.24851503009, 26554.601680974414, 26655.866720666272, 26672.46655066849, 26796.732032679425, 27175.1847444577], "value": 22289.170758076223, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [440.57484527431023, 440.7950303109054, 448.885534188782, 448.92817149256126, 453.5351264953424, 20801.0, 22765.658515122264, 22944.77055229447, 23074.423139421502, 23091.0, 22819.657705134396, 22990.770092299073, 23260.0, 23295.184668536604, 23436.296911092653, 5936.614120082191, 5952.226210592638, 6103.6032657877095, 6150.66171360575, 6178.660173690445, 4669.066186762661, 4855.490173531782, 6046.697665116749, 6094.939050609503, 6145.016797312431, 6601.339866013408, 6900.27547107554, 6903.275156108612, 7061.435085193198, 7074.504784665076, 6914.688839002257, 6946.895796563055, 6976.93023069773, 6996.300369962963, 7029.7891063267925, 6164.137020817089, 6189.133521307021, 6228.096925945758, 6232.470240029603, 6238.1266622672865, 26386.604200937003, 26516.46967060667, 26635.20094397171, 26655.733442665518, 26672.59991100135, 2769.8476583787883, 2848.430313937221, 2891.6819149893495, 2906.607607972918, 2919.138854038064, 11230.55077796887, 12037.699057523545, 12063.517459301618, 13963.232022238773, 15248.161351125684, 1996.9101390437465, 2053.7022131790955, 2062.226665000625, 2069.5653912678354, 2073.1914553324214, 100939.0, 102725.0, 102963.0, 104036.0, 104785.99999999924, 12261.38693065361, 12690.619281421388, 13004.674883127998, 13155.144915580457, 13157.210567365797, 18450.723239151423, 18532.0, 18533.351332703292, 18590.628187436174, 18599.0, 9101.954490227507, 9105.635774569075, 9218.308626853013, 9290.442573445614, 9310.115539023782, 8861.379703420827, 8875.556222188994, 8927.553622318988, 9079.273658107468, 9084.636614535477, 5440.836774896759, 5553.861153471114, 5554.527865131509, 5576.302962129734, 5704.971475142598, 1919.606480671459, 2105.557832855087, 2182.6835108909117, 2238.7089678342036, 2282.4179834142187, 949.2738055387634, 953.5613617735919, 957.9042095790504, 970.9174720148725, 981.7054883535054, 18952.0, 21324.573508529742, 21689.457763556038, 21864.781352186594, 21888.075183083998, 958.8178246133212, 973.5424350555228, 973.9366941148803, 974.3666616699202, 978.921686265097, 11474.885251147381, 11909.583164589198, 12137.21108127969, 12198.756024879453, 12298.20061695987, 666743.0, 669333.0, 712232.0, 755712.0, 789285.0, 83007.0, 102060.0, 109764.4511777436, 111195.0, 114106.42946785213, 1121.147927575049, 1152.573547787324, 1164.1559869095008, 1172.372780562395, 1177.7526719388852, 18020.36928707489, 18700.158492868126, 19116.617667646846, 19166.0, 19374.0, 43738.56261437472, 44214.0, 45654.771726142484, 45860.31209531793, 47059.0, 65574.67212663907, 65859.67070164619, 66476.66761666161, 66592.33407666055, 66600.6669966647, 7196.640167991684, 9664.323497355117, 9717.514124293899, 9883.55524001436, 10117.19062475015, 13756.312184390941, 14777.113373197213, 15012.924935375253, 15139.243037848284, 15336.616584585474, 12041.157119001586, 12165.45255463524, 12356.567520136752, 12370.567030153901, 12863.935680321538, 12287.508499659914, 12936.547220847226, 13154.60536183916, 13698.315084245549, 13706.725865482835, 13168.0, 13238.139520931109, 13400.798988015382, 13523.323833808467, 13782.310884455937, 9799.265055120752, 9855.605775768889, 10033.431524984193, 10167.491625418847, 10306.587736490756, 12077.094217933514, 12255.0, 12313.384330783247, 12376.504939802307, 12879.162854414433], "value": 10458.743808872685, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1480.1341215388998, 1491.5898128014794, 1515.9924200379, 1525.5499627609854, 1534.716077525657, 8066.71766488173, 8514.70198543051, 8519.1906768857, 8520.403571749972, 8523.403361764678, 7608.125065617455, 7845.646945887434, 8314.0, 8550.828983420344, 8584.828303433927, 2474.8886300116537, 2517.785988191006, 2519.634652975327, 2527.747225277476, 2531.4683916377585, 2510.7740303372693, 2549.6430499730054, 2560.2319304208754, 2563.269468201563, 2570.5244529761962, 2412.16780210827, 2431.6109422492405, 2467.5064987002584, 2476.2447453526756, 2476.925692229236, 2361.3034154924426, 2377.1917548033666, 2379.6668466414544, 2385.7256415512093, 2400.0879665726998, 2387.8925448354867, 2412.5054363855365, 2414.8068154547595, 2462.236706620953, 2464.4701389201227, 8692.261157801595, 8780.078091800333, 8789.912100878973, 8790.077041910636, 8794.384393092487, 5342.118550439173, 5486.533644640211, 5492.038893193675, 5492.697901615449, 5494.780208791643, 3494.0915362006062, 3548.6451354864307, 3563.875264365761, 3595.406757884946, 3667.743257971943, 1308.2085338370243, 1363.6727185475513, 1389.9930500347534, 1402.4179965314381, 1451.804006459125, 12080.395980200954, 12120.272783632921, 12120.878791212062, 12159.878401215874, 12174.756504869853, 4697.7651117444675, 4820.084184005028, 4867.756612169377, 4950.529699678525, 4969.254611808257, 9458.47978361183, 9529.571169297398, 9539.666111686058, 9540.666076687283, 9553.952230238943, 5408.486193811582, 5431.565474762009, 5438.211459338374, 5445.346558413015, 5454.045542030129, 4899.58353539946, 5130.871728206825, 5199.454057324002, 5200.947990520046, 5206.869828254324, 4031.33719256089, 4072.857449989295, 4107.404426358161, 4118.114605359862, 4154.376843473443, 1274.4328773695802, 1286.8841804237663, 1287.2984223597973, 1299.3957809618385, 1299.4802079168219, 963.8843338799389, 991.1723710701501, 993.4684943555163, 999.0808456220295, 1000.1198944928417, 5767.36558978512, 5886.117082437669, 5905.143754155709, 5905.557083218776, 5950.583459157818, 631.0754744299624, 644.3685188515282, 648.2642201101689, 655.3446553446554, 657.8454063295122, 3810.256999884996, 4113.03343714227, 4128.401381799682, 4236.068065025689, 4279.272523670983, 10034.949825250827, 10183.847242291371, 10265.178785697126, 10320.0, 10521.473926303808, 10197.18422526196, 10259.487025648688, 10306.227032972558, 10378.273520853469, 10389.480525973822, 7900.446968712135, 8176.427650064557, 8212.055613604392, 8212.876806848022, 8218.383621228431, 5582.637128586629, 5656.971715141398, 5734.2258795062135, 5738.885222295447, 5815.505682017076, 9416.293777966543, 9635.277354198603, 9687.806243875224, 9747.561359738687, 9775.266854985763, 9398.20115290208, 9745.610175592898, 10014.39913605186, 10045.0, 10045.347052441568, 7270.382017528358, 7329.1937886833475, 7343.082114735658, 7343.4492413068165, 7344.30229128232, 8338.458000229966, 8413.62138703772, 8421.19998600132, 8426.578671066545, 8431.494110353398, 7506.699732010877, 7570.962145189239, 7635.350995165251, 7783.610819459118, 7796.883046754417, 7379.409647228316, 7526.661300241392, 7539.736109236151, 7543.73596924105, 7555.433342499225, 6854.794356169323, 6937.340952609494, 7023.824404389727, 7028.683709232994, 7035.753748618774, 4940.92588611164, 4987.80048798044, 5010.949890501049, 5022.096022715946, 5220.634555581073, 5339.599530035185, 5390.595705322038, 5443.618946673695, 5450.863728406822, 5684.261046063985], "value": 4630.232047539199, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.7703377973215, 409.75619506393684, 411.9985902698839, 415.95840415958406, 422.0777600941942, 5233.816816411427, 5324.440933701959, 5389.272448219489, 5400.83797486075, 5461.97906774494, 5249.317588713471, 5270.683758974465, 5280.445553216915, 5314.202869569566, 5351.779011710136, 4240.957590424103, 4242.363645453192, 4244.681648876347, 4262.936055959163, 4271.273883439822, 4079.0, 4149.481314835645, 4207.137536804948, 4261.850835220768, 4285.764282964436, 4216.388623649569, 4223.704340696153, 4226.556211597784, 4238.597333253336, 4283.507396649378, 4265.594768496988, 4280.250956082704, 4290.5709429057, 4297.59172878576, 4298.20483210607, 3841.1741475582885, 3875.4110814565893, 3924.50943632046, 3931.1744533647684, 3935.960640393617, 5226.843194704127, 5227.529522342969, 5227.738613069369, 5241.318628578299, 5286.682799032071, 4970.627202959792, 4985.980677825451, 4997.325361076281, 5002.624803139779, 5024.547790698854, 5455.936092461971, 5587.7485513152005, 5621.915671264935, 5681.204631351614, 5705.972924873521, 4316.438862947828, 4337.652987760972, 4339.934900976488, 4354.521002689701, 4379.781010949471, 5861.941380586182, 5865.472107510302, 5877.853053673693, 5884.146798714205, 5887.175795388606, 4032.354823228269, 4189.413482112506, 4257.148570285955, 4466.173757854807, 4473.329000649928, 4083.9795801020805, 4266.978665106717, 4273.743575385424, 4282.272013757669, 4282.507511636201, 4728.976355118202, 4771.188897887368, 4869.6591238612955, 4870.318155458239, 4871.658983871166, 5651.0, 5657.830265092054, 5672.546196304285, 5702.971485142548, 5745.080787074048, 1422.8363738170035, 1444.2201211345755, 1446.5298777897015, 1447.9068303430843, 1460.167704408477, 977.1645243316862, 983.6114734679904, 985.4284514981293, 990.2770977186694, 998.4159266828987, 5172.55604249477, 5328.706921119376, 5343.519083282523, 5348.518633322942, 5438.592105592096, 5637.323521177403, 5695.202671625976, 5699.373068962411, 5702.885942281131, 5725.914111288334, 5349.058018090035, 5365.597580181502, 5393.83818485446, 5416.0, 5452.482014208644, 2890.5664150377193, 2998.8050776699447, 3014.8794048238265, 3021.1842802443216, 3022.9546556801665, 5775.27809023872, 5795.884082318415, 5846.678432686158, 5849.941500585025, 5868.237129173265, 5544.584156188302, 5695.689991302023, 5727.336788393417, 5748.367679555246, 5759.481646651821, 5646.632968857093, 5664.376918538957, 5672.205891175321, 5792.739326730307, 5797.623154494944, 5531.0, 5559.888802223852, 5607.5607110906885, 5624.718764061862, 5635.605507614428, 5258.605604579749, 5440.809571665131, 5514.503694667339, 5529.723513824212, 5537.5569954404355, 5783.479486846204, 5796.565257605781, 5796.59423840344, 5812.3025236971835, 5825.679587622722, 4027.838886444509, 4154.896127596834, 4166.979165104155, 4168.144820797763, 4188.287991041591, 5584.337078539465, 5607.719614019201, 5616.0, 5629.521490673339, 5649.802256920988, 5479.561635069105, 5482.259894914136, 5502.257195278587, 5521.950829342412, 5524.005678977823, 5323.349761573924, 5407.756650950795, 5485.369182543899, 5503.917441238465, 5538.67375702198, 5377.220303056113, 5414.404415514212, 5447.1829225616475, 5455.236266922713, 5467.972660136833, 5484.287042684426, 5503.944960550343, 5517.034518959086, 5520.696361700145, 5552.944470555242, 5251.579873610026, 5409.648372855751, 5581.218629391969, 5605.747741351567, 5633.521150702072], "value": 4317.510057268121, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [835.2148979958835, 856.242225630317, 858.974230773077, 916.0441124155104, 932.598982437552, 15791.526254212378, 17312.653746925054, 17514.036727979958, 17540.736888946645, 17598.03210823406, 15980.200989950485, 16142.6278766305, 16447.506574802774, 16471.258793354296, 16597.41909033184, 509.28191250337034, 520.9583233341342, 786.0920636664662, 792.2711105782694, 792.8374683189961, 756.5574139128589, 760.8440269744689, 766.938644908406, 767.8809784483414, 769.273036980054, 836.0761358698642, 837.3803385494721, 837.7821766340734, 837.9748607541784, 838.1534650003509, 714.8141483214401, 728.5337384074144, 833.017039892926, 833.6832003838563, 833.687367237286, 605.9759007277687, 613.187526527353, 613.6042252746997, 615.8460384903774, 616.100493279812, 16191.028538287741, 16715.66568668632, 16744.0, 16757.581060473465, 16766.0, 14843.183624900626, 15203.543893683207, 15321.387144514318, 15654.9217253913, 15705.450309239122, 13984.370703318375, 14080.92959535206, 14107.435702571987, 14337.21145337006, 14390.640233994129, 4536.412255710508, 4537.9773101134615, 4546.8863278417975, 4602.930956035662, 4675.228587283094, 82926.0, 83034.0, 83510.0, 84929.15070849274, 85170.57414712886, 11820.522434695664, 11834.940825295991, 12067.275963442222, 12122.0, 12170.208936419105, 22447.887760561094, 22752.20367287137, 22809.087636494354, 22811.657825132635, 22817.429564260696, 8598.527081010605, 8631.525266110299, 8873.334499912533, 8936.731898043068, 8997.505137217386, 4854.271859221074, 4891.26631005352, 4891.51084891508, 4909.509049095133, 5051.772670229849, 3720.107174278208, 3775.6413140752134, 3775.6979441645153, 3777.131259810259, 3778.3387907116144, 633.1578999930082, 635.2377147423018, 635.9777407790798, 638.2213699286955, 642.5662677692538, 756.9848603027908, 764.6116695013196, 767.0450289389634, 782.1435528096725, 789.2659826361539, 10541.947290263499, 10692.572297108029, 10948.288361256493, 11734.151694822678, 12159.817602735966, 680.9080774095532, 704.3731079339392, 711.8256027273351, 736.1791602363327, 810.0967421325298, 5163.896722065538, 5507.129766215231, 5658.0, 5659.43405659439, 5690.829275121753, 60423.0, 60564.091538626955, 61353.0, 66252.0, 73899.0, 63874.0, 66491.0, 66598.66700666562, 67166.66416667885, 67185.66407167933, 58991.41008589945, 59124.99999999914, 59801.0, 60169.69915150396, 60403.69798150981, 10727.731806704895, 10911.181661375269, 11069.514208785482, 11214.66356009321, 11314.264572802742, 37649.24701506009, 38253.234935300585, 40560.0, 41147.0, 42821.78589107034, 48868.0, 50713.746431269086, 50843.983120338125, 51995.0, 53934.0, 14298.142111473346, 14333.426662933365, 14388.136711797326, 14394.0, 14570.781438278646, 15916.761248581512, 15999.440019599258, 16269.186540673156, 16321.836781632506, 16413.67172656564, 15086.849131508545, 15200.391984320504, 15211.543653690407, 15220.771688424904, 15273.312700928707, 14233.715325693222, 14323.57029289123, 14644.267786610413, 15000.549983500512, 15282.847171528587, 14588.708225835211, 14741.484048058266, 14770.34013200081, 14891.25543722788, 15245.771313430529, 11726.41367931617, 12025.819612705991, 12207.0, 12518.0, 12526.185797923106, 11685.883141168479, 11744.882551174378, 11835.763284734428, 11914.52341906314, 12068.396580171131], "value": 7580.586883922895, "unit": "score"}], "name": "dromaeo_css", "value": 7598.725154431595, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 110.0, 111.0, 111.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 117.0, 123.0, 154.0, 123.0, 118.0, 117.0, 117.0, 136.0, 118.0], "value": 126.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 160.0, 163.0, 160.0, 160.0, 161.0, 160.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 116.0, 76.0, 75.0, 75.0, 75.0, 89.0, 75.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 98.0, 83.0, 82.0, 83.0, 95.0, 83.0, 82.0, 99.0], "value": 87.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 148.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 48.0, 48.0, 48.0, 48.0, 48.0, 49.0, 49.0, 50.0], "value": 48.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 63.0, 64.0, 64.0, 63.0, 63.0, 64.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 83.0, 77.0, 76.0, 76.0, 85.0, 77.0, 75.0, 74.0, 76.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 121.0, 120.0, 123.0, 122.0, 119.0, 131.0, 119.0, 161.0, 127.0], "value": 127.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 157.0, 160.0, 158.0, 160.0, 161.0, 159.0, 163.0, 165.0, 157.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 59.0, 63.0, 62.0, 60.0, 58.0, 60.0, 59.0], "value": 60.1, "unit": "score"}], "name": "kraken", "value": 1463.0, "alertThreshold": 2.0}]} 09:30:54 INFO - Return code: 0 09:30:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:30:54 ERROR - # TBPL SUCCESS # 09:30:54 INFO - Running post-action listener: _resource_record_post_action 09:30:54 INFO - [mozharness: 2017-01-23 17:30:54.709593Z] Finished run-tests step (success) 09:30:54 INFO - Running post-run listener: _resource_record_post_run 09:30:54 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 266240; Write bytes: 353636352; Read time: 36; Write time: 217284 09:30:54 INFO - TinderboxPrint: CPU usage
13.0% 09:30:54 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 36 09:30:54 INFO - TinderboxPrint: I/O write bytes / time
353,636,352 / 217,284 09:30:54 INFO - TinderboxPrint: CPU idle
8,250.7 (86.9%) 09:30:54 INFO - TinderboxPrint: CPU user
1,194.8 (12.6%) 09:30:54 INFO - TinderboxPrint: Swap in / out
0 / 0 09:30:54 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109441024; Read time: 0; Write time: 91208 09:30:54 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 266240; Write bytes: 243412992; Read time: 36; Write time: 126056 09:30:55 INFO - Running post-run listener: _upload_blobber_files 09:30:55 INFO - Blob upload gear active. 09:30:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:30:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:30:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:30:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:30:55 INFO - (blobuploader) - INFO - Open directory for files ... 09:30:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:30:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:30:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:30:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:30:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:30:56 INFO - (blobuploader) - INFO - Done attempting. 09:30:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:30:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:30:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:30:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:30:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:30:57 INFO - (blobuploader) - INFO - Done attempting. 09:30:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:30:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:30:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:30:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:30:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:30:58 INFO - (blobuploader) - INFO - Done attempting. 09:30:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:30:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:30:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:31:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:31:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:31:01 INFO - (blobuploader) - INFO - Done attempting. 09:31:01 INFO - (blobuploader) - INFO - Iteration through files over. 09:31:01 INFO - Return code: 0 09:31:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:31:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:31:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/0cc1f61fc3ed36937f9ef7de68120fd4b4d542d595235ff4eed3f99ad54acac23e4b76e330ba8fe93e4ac6c8e5a2aaa26a6b53444984d9051367459bbb2b7654", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/2334602a11870564fa42fb86fe9009bbc2436ef1799ca4ba0c33997ff9c153d9a129b5660ef1749d524f6e40f59f24cc073dbea49e04f2f1a687ab9b97c28bc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3066312a89e1f5c1219b27242448506146acd174172a26f72fff7528a49d8bb213857c2eee009d8d0b2f43dab508a9bc45124e71613d19a9215c72cce3d60175", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/5807004a70dfa2af0b6d66dff1db17ebbb9dd35342628e60d94464e5fb94ebebf71e0026cd3d7ff034afa12a41ca5e501558c9469d1b90a5e0851407e557225e"} 09:31:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:31:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:31:01 INFO - Contents: 09:31:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/0cc1f61fc3ed36937f9ef7de68120fd4b4d542d595235ff4eed3f99ad54acac23e4b76e330ba8fe93e4ac6c8e5a2aaa26a6b53444984d9051367459bbb2b7654", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/2334602a11870564fa42fb86fe9009bbc2436ef1799ca4ba0c33997ff9c153d9a129b5660ef1749d524f6e40f59f24cc073dbea49e04f2f1a687ab9b97c28bc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3066312a89e1f5c1219b27242448506146acd174172a26f72fff7528a49d8bb213857c2eee009d8d0b2f43dab508a9bc45124e71613d19a9215c72cce3d60175", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/5807004a70dfa2af0b6d66dff1db17ebbb9dd35342628e60d94464e5fb94ebebf71e0026cd3d7ff034afa12a41ca5e501558c9469d1b90a5e0851407e557225e"} 09:31:01 INFO - Running post-run listener: copy_logs_to_upload_dir 09:31:01 INFO - Copying logs to upload dir... 09:31:01 INFO - mkdir: /builds/slave/test/build/upload/logs 09:31:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.262080 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-23 09:31:01.027823) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 09:31:01.031399) ========= 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=0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/0cc1f61fc3ed36937f9ef7de68120fd4b4d542d595235ff4eed3f99ad54acac23e4b76e330ba8fe93e4ac6c8e5a2aaa26a6b53444984d9051367459bbb2b7654", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/2334602a11870564fa42fb86fe9009bbc2436ef1799ca4ba0c33997ff9c153d9a129b5660ef1749d524f6e40f59f24cc073dbea49e04f2f1a687ab9b97c28bc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3066312a89e1f5c1219b27242448506146acd174172a26f72fff7528a49d8bb213857c2eee009d8d0b2f43dab508a9bc45124e71613d19a9215c72cce3d60175", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/5807004a70dfa2af0b6d66dff1db17ebbb9dd35342628e60d94464e5fb94ebebf71e0026cd3d7ff034afa12a41ca5e501558c9469d1b90a5e0851407e557225e"} build_url:https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011561 build_url: 'https://queue.taskcluster.net/v1/task/L6V-94QgQkS2BXY6NM7acQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/0cc1f61fc3ed36937f9ef7de68120fd4b4d542d595235ff4eed3f99ad54acac23e4b76e330ba8fe93e4ac6c8e5a2aaa26a6b53444984d9051367459bbb2b7654", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/2334602a11870564fa42fb86fe9009bbc2436ef1799ca4ba0c33997ff9c153d9a129b5660ef1749d524f6e40f59f24cc073dbea49e04f2f1a687ab9b97c28bc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3066312a89e1f5c1219b27242448506146acd174172a26f72fff7528a49d8bb213857c2eee009d8d0b2f43dab508a9bc45124e71613d19a9215c72cce3d60175", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/5807004a70dfa2af0b6d66dff1db17ebbb9dd35342628e60d94464e5fb94ebebf71e0026cd3d7ff034afa12a41ca5e501558c9469d1b90a5e0851407e557225e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 09:31:01.056680) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 09:31:01.057026) ========= 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=0333a256a5e4f052382dd180000001b1-1485191424.440492-627470813 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004497 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 09:31:01.142376) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 09:31:01.142785) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 09:31:01.143132) ========= ========= Total master_lag: 0.17 =========