builder: autoland_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-014 starttime: 1471064426.57 results: success (0) buildid: 20160812212417 builduid: 7fd3c8ecea34456795571ffb47cf05b6 revision: b17f42ecbc3cb0c36ca7215762c5f972722c8321 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 22:00:26.572459) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-12 22:00:26.572845) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 22:00:26.573116) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-12 22:00:26.589804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 22:00:26.590075) ========= 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=31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-12 22:00:27-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.2M=0s 2016-08-12 22:00:27 (46.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114221 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 22:00:26.718129) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 22:00:26.718454) ========= 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=31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018550 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 22:00:26.768110) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 22:00:26.768481) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev b17f42ecbc3cb0c36ca7215762c5f972722c8321 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev b17f42ecbc3cb0c36ca7215762c5f972722c8321 --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=31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-12 22:00:27,647 truncating revision to first 12 chars 2016-08-12 22:00:27,647 Setting DEBUG logging. 2016-08-12 22:00:27,647 attempt 1/10 2016-08-12 22:00:27,647 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/b17f42ecbc3c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-12 22:00:27,941 unpacking tar archive at: autoland-b17f42ecbc3c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.632048 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 22:00:27.417247) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 22:00:27.417538) ========= script_repo_revision: b17f42ecbc3cb0c36ca7215762c5f972722c8321 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-12 22:00:27.417911) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 22:00:27.418173) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-12 22:00:27.431020) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-12 22:00:27.431295) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:00:28 INFO - MultiFileLogger online at 20160812 22:00:28 in /builds/slave/test 22:00:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 22:00:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:00:28 INFO - {'append_to_log': False, 22:00:28 INFO - 'base_work_dir': '/builds/slave/test', 22:00:28 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 22:00:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:00:28 INFO - 'branch': 'Autoland-Non-PGO', 22:00:28 INFO - 'buildbot_json_path': 'buildprops.json', 22:00:28 INFO - 'config_files': ('talos/linux_config.py',), 22:00:28 INFO - 'default_actions': ('clobber', 22:00:28 INFO - 'read-buildbot-config', 22:00:28 INFO - 'download-and-extract', 22:00:28 INFO - 'populate-webroot', 22:00:28 INFO - 'create-virtualenv', 22:00:28 INFO - 'install', 22:00:28 INFO - 'run-tests'), 22:00:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:00:28 INFO - 'download_minidump_stackwalk': True, 22:00:28 INFO - 'download_symbols': 'ondemand', 22:00:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:00:28 INFO - 'tooltool.py': '/tools/tooltool.py', 22:00:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:00:28 INFO - '/tools/misc-python/virtualenv.py')}, 22:00:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:00:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:00:28 INFO - 'installer_path': 'installer.exe', 22:00:28 INFO - 'log_level': 'info', 22:00:28 INFO - 'log_name': 'talos', 22:00:28 INFO - 'log_to_console': True, 22:00:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:00:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:00:28 INFO - 'opt_config_files': (), 22:00:28 INFO - 'pip_index': False, 22:00:28 INFO - 'sps_profile': False, 22:00:28 INFO - 'sps_profile_interval': 0, 22:00:28 INFO - 'suite': 'dromaeojs-e10s', 22:00:28 INFO - 'system_bits': '32', 22:00:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:00:28 INFO - 'title': 'talos-linux64-ix-014', 22:00:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:00:28 INFO - 'use_talos_json': True, 22:00:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:00:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:00:28 INFO - 'work_dir': 'build'} 22:00:28 INFO - [mozharness: 2016-08-13 05:00:28.399473Z] Running clobber step. 22:00:28 INFO - Running pre-action listener: _resource_record_pre_action 22:00:28 INFO - Running main action method: clobber 22:00:28 INFO - rmtree: /builds/slave/test/build 22:00:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:00:29 INFO - Running post-action listener: _resource_record_post_action 22:00:29 INFO - [mozharness: 2016-08-13 05:00:29.384745Z] Finished clobber step (success) 22:00:29 INFO - [mozharness: 2016-08-13 05:00:29.384845Z] Running read-buildbot-config step. 22:00:29 INFO - Running pre-action listener: _resource_record_pre_action 22:00:29 INFO - Running main action method: read_buildbot_config 22:00:29 INFO - Using buildbot properties: 22:00:29 INFO - { 22:00:29 INFO - "project": "", 22:00:29 INFO - "product": "firefox", 22:00:29 INFO - "script_repo_revision": "production", 22:00:29 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 22:00:29 INFO - "repository": "", 22:00:29 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs-e10s", 22:00:29 INFO - "buildid": "20160812212417", 22:00:29 INFO - "pgo_build": "False", 22:00:29 INFO - "basedir": "/builds/slave/test", 22:00:29 INFO - "buildnumber": 277, 22:00:29 INFO - "slavename": "talos-linux64-ix-014", 22:00:29 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 22:00:29 INFO - "platform": "ubuntu64_hw", 22:00:29 INFO - "scheduler": "tests-autoland-linux64-talos", 22:00:29 INFO - "branch": "autoland", 22:00:29 INFO - "repo_path": "integration/autoland", 22:00:29 INFO - "revision": "b17f42ecbc3cb0c36ca7215762c5f972722c8321", 22:00:29 INFO - "stage_platform": "linux64", 22:00:29 INFO - "builduid": "7fd3c8ecea34456795571ffb47cf05b6", 22:00:29 INFO - "slavebuilddir": "test" 22:00:29 INFO - } 22:00:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/RK3EDr6jRZmg9dx--b-nYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 22:00:29 INFO - Running post-action listener: _resource_record_post_action 22:00:29 INFO - [mozharness: 2016-08-13 05:00:29.387241Z] Finished read-buildbot-config step (success) 22:00:29 INFO - [mozharness: 2016-08-13 05:00:29.387328Z] Running download-and-extract step. 22:00:29 INFO - Running pre-action listener: _resource_record_pre_action 22:00:29 INFO - Running main action method: download_and_extract 22:00:29 INFO - mkdir: /builds/slave/test/build/tests 22:00:29 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')]} 22:00:29 INFO - trying https://queue.taskcluster.net/v1/task/RK3EDr6jRZmg9dx--b-nYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 22:00:29 INFO - Downloading https://queue.taskcluster.net/v1/task/RK3EDr6jRZmg9dx--b-nYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 22:00:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RK3EDr6jRZmg9dx--b-nYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 22:00:29 INFO - Downloaded 1361 bytes. 22:00:29 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 22:00:29 INFO - Using the following test package requirements: 22:00:29 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 22:00:29 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:00:29 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:00:29 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:29 INFO - u'jsshell-linux-x86_64.zip'], 22:00:29 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:00:29 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 22:00:29 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:00:29 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:00:29 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:00:29 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 22:00:29 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:00:29 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:00:29 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')]} 22:00:29 INFO - trying https://queue.taskcluster.net/v1/task/RK3EDr6jRZmg9dx--b-nYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:00:29 INFO - Downloading https://queue.taskcluster.net/v1/task/RK3EDr6jRZmg9dx--b-nYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:00:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RK3EDr6jRZmg9dx--b-nYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:00:30 INFO - Downloaded 20265980 bytes. 22:00:30 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 22:00:35 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:00:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:00:35 INFO - trying https://queue.taskcluster.net/v1/task/RK3EDr6jRZmg9dx--b-nYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:00:35 INFO - Downloading https://queue.taskcluster.net/v1/task/RK3EDr6jRZmg9dx--b-nYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 22:00:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RK3EDr6jRZmg9dx--b-nYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:00:36 INFO - Downloaded 20265980 bytes. 22:00:36 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 22:00:40 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')]} 22:00:40 INFO - trying https://queue.taskcluster.net/v1/task/RK3EDr6jRZmg9dx--b-nYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 22:00:40 INFO - Downloading https://queue.taskcluster.net/v1/task/RK3EDr6jRZmg9dx--b-nYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 22:00:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RK3EDr6jRZmg9dx--b-nYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:00:41 INFO - Downloaded 14413719 bytes. 22:00:41 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 22:00:41 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')]} 22:00:41 INFO - trying https://queue.taskcluster.net/v1/task/RK3EDr6jRZmg9dx--b-nYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:00:41 INFO - Downloading https://queue.taskcluster.net/v1/task/RK3EDr6jRZmg9dx--b-nYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:00:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RK3EDr6jRZmg9dx--b-nYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:00:43 INFO - Downloaded 55621477 bytes. 22:00:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RK3EDr6jRZmg9dx--b-nYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:00:43 INFO - mkdir: /builds/slave/test/properties 22:00:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:00:43 INFO - Writing to file /builds/slave/test/properties/build_url 22:00:43 INFO - Contents: 22:00:43 INFO - build_url:https://queue.taskcluster.net/v1/task/RK3EDr6jRZmg9dx--b-nYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 22:00:43 INFO - Running post-action listener: _resource_record_post_action 22:00:43 INFO - Running post-action listener: set_extra_try_arguments 22:00:43 INFO - [mozharness: 2016-08-13 05:00:43.850609Z] Finished download-and-extract step (success) 22:00:43 INFO - [mozharness: 2016-08-13 05:00:43.850833Z] Running populate-webroot step. 22:00:43 INFO - Running pre-action listener: _resource_record_pre_action 22:00:43 INFO - Running main action method: populate_webroot 22:00:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:00:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:00:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:00:43 INFO - '--tppagecycles', 22:00:43 INFO - '7'], 22:00:43 INFO - 'tests': ['tsvgm']}}, 22:00:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:00:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:00:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:00:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:00:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:00:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:00:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:43 INFO - 'talos_options': ['--disable-e10s'], 22:00:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:00:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:00:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:43 INFO - 'talos_options': ['--disable-e10s'], 22:00:43 INFO - 'tests': ['damp', 'tps']}, 22:00:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:43 INFO - 'tests': ['damp', 'tps']}, 22:00:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:00:43 INFO - 'tests': ['dromaeo_dom']}, 22:00:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:00:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 22:00:43 INFO - 'tests': ['basic_compositor_video']}, 22:00:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 22:00:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:00:43 INFO - 'tests': ['a11yr', 22:00:43 INFO - 'ts_paint', 22:00:43 INFO - 'tpaint', 22:00:43 INFO - 'sessionrestore', 22:00:43 INFO - 'sessionrestore_no_auto_restore', 22:00:43 INFO - 'tabpaint']}, 22:00:43 INFO - 'other-e10s': {'tests': ['a11yr', 22:00:43 INFO - 'ts_paint', 22:00:43 INFO - 'tpaint', 22:00:43 INFO - 'sessionrestore', 22:00:43 INFO - 'sessionrestore_no_auto_restore', 22:00:43 INFO - 'tabpaint']}, 22:00:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:00:43 INFO - 'ts_paint', 22:00:43 INFO - 'tpaint', 22:00:43 INFO - 'sessionrestore', 22:00:43 INFO - 'sessionrestore_no_auto_restore', 22:00:43 INFO - 'tabpaint']}, 22:00:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:00:43 INFO - 'ts_paint', 22:00:43 INFO - 'tpaint', 22:00:43 INFO - 'sessionrestore', 22:00:43 INFO - 'sessionrestore_no_auto_restore', 22:00:43 INFO - 'tabpaint']}, 22:00:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:00:43 INFO - 'tests': ['a11yr', 22:00:43 INFO - 'ts_paint', 22:00:43 INFO - 'tpaint', 22:00:43 INFO - 'sessionrestore', 22:00:43 INFO - 'sessionrestore_no_auto_restore', 22:00:43 INFO - 'tabpaint']}, 22:00:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:00:43 INFO - 'tests': ['a11yr', 22:00:43 INFO - 'ts_paint', 22:00:43 INFO - 'tpaint', 22:00:43 INFO - 'sessionrestore', 22:00:43 INFO - 'sessionrestore_no_auto_restore', 22:00:43 INFO - 'tabpaint']}, 22:00:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:00:43 INFO - 'tests': ['tsvgx', 22:00:43 INFO - 'tsvgr_opacity', 22:00:43 INFO - 'tart', 22:00:43 INFO - 'tscrollx', 22:00:43 INFO - 'cart']}, 22:00:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:00:43 INFO - 'tsvgr_opacity', 22:00:43 INFO - 'tart', 22:00:43 INFO - 'tscrollx', 22:00:43 INFO - 'cart']}, 22:00:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:43 INFO - 'talos_options': ['--disable-e10s'], 22:00:43 INFO - 'tests': ['tp5o']}, 22:00:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:43 INFO - 'tests': ['tp5o']}, 22:00:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:43 INFO - 'talos_options': ['--disable-e10s', 22:00:43 INFO - '--xperf_path', 22:00:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:00:43 INFO - 'tests': ['tp5n']}, 22:00:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:00:43 INFO - 'talos_options': ['--xperf_path', 22:00:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:00:43 INFO - 'tests': ['tp5n']}}, 22:00:43 INFO - 'talos.zip': {'path': '', 22:00:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:00:43 INFO - Running post-action listener: _resource_record_post_action 22:00:43 INFO - [mozharness: 2016-08-13 05:00:43.873121Z] Finished populate-webroot step (success) 22:00:43 INFO - [mozharness: 2016-08-13 05:00:43.873208Z] Running create-virtualenv step. 22:00:43 INFO - Running pre-action listener: _resource_record_pre_action 22:00:43 INFO - Running main action method: create_virtualenv 22:00:43 INFO - Creating virtualenv /builds/slave/test/build/venv 22:00:43 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 22:00:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:00:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:00:43 INFO - Using real prefix '/usr' 22:00:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:00:44 INFO - Installing distribute.............................................................................................................................................................................................done. 22:00:46 INFO - Installing pip.................done. 22:00:46 INFO - Return code: 0 22:00:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:00: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')]} 22:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00: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')]} 22:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f11f967df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29090>, '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 0x2b2c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ce40>, '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': '31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312', '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 22:00: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', 'pip>=1.5'] in /builds/slave/test/build 22:00: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 pip>=1.5 22:00:46 INFO - Using env: {'DISPLAY': ':0', 22:00:46 INFO - 'HOME': '/home/cltbld', 22:00:46 INFO - 'LANG': 'en_US.UTF-8', 22:00:46 INFO - 'LANGUAGE': 'en_US:en', 22:00:46 INFO - 'LOGNAME': 'cltbld', 22:00:46 INFO - 'MAIL': '/var/mail/cltbld', 22:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:46 INFO - 'MOZ_NO_REMOTE': '1', 22:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:46 INFO - 'NO_EM_RESTART': '1', 22:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:46 INFO - 'PWD': '/builds/slave/test', 22:00:46 INFO - 'SHELL': '/bin/bash', 22:00:46 INFO - 'SHLVL': '1', 22:00:46 INFO - 'TERM': 'linux', 22:00:46 INFO - 'TMOUT': '86400', 22:00:46 INFO - 'USER': 'cltbld', 22:00:46 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312', 22:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:46 INFO - '_': '/tools/buildbot/bin/python'} 22:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:46 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 22:00:46 INFO - Cleaning up... 22:00:46 INFO - Return code: 0 22:00:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 22:00: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')]} 22:00:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00: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')]} 22:00:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00: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', '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 0x7f11f967df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29090>, '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 0x2b2c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ce40>, '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': '31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312', '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 22:00: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', 'psutil>=3.1.1'] in /builds/slave/test/build 22:00: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 psutil>=3.1.1 22:00:46 INFO - Using env: {'DISPLAY': ':0', 22:00:46 INFO - 'HOME': '/home/cltbld', 22:00:46 INFO - 'LANG': 'en_US.UTF-8', 22:00:46 INFO - 'LANGUAGE': 'en_US:en', 22:00:46 INFO - 'LOGNAME': 'cltbld', 22:00:46 INFO - 'MAIL': '/var/mail/cltbld', 22:00:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:46 INFO - 'MOZ_NO_REMOTE': '1', 22:00:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:46 INFO - 'NO_EM_RESTART': '1', 22:00:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:46 INFO - 'PWD': '/builds/slave/test', 22:00:46 INFO - 'SHELL': '/bin/bash', 22:00:46 INFO - 'SHLVL': '1', 22:00:46 INFO - 'TERM': 'linux', 22:00:46 INFO - 'TMOUT': '86400', 22:00:46 INFO - 'USER': 'cltbld', 22:00:46 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312', 22:00:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:46 INFO - '_': '/tools/buildbot/bin/python'} 22:00:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:46 INFO - Downloading/unpacking psutil>=3.1.1 22:00:46 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 22:00:46 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 22:00:46 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 22:00:46 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 22:00:46 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 22:00:46 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 22:00:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:00:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:00:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:00:48 INFO - Installing collected packages: psutil 22:00:48 INFO - Running setup.py install for psutil 22:00:48 INFO - building 'psutil._psutil_linux' extension 22:00:48 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 22:00:49 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 22:00:49 INFO - building 'psutil._psutil_posix' extension 22:00:49 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 22:00:49 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 22:00:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:00:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:00:49 INFO - Successfully installed psutil 22:00:49 INFO - Cleaning up... 22:00:49 INFO - Return code: 0 22:00:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 22:00: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')]} 22:00:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00: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')]} 22:00:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f11f967df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29090>, '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 0x2b2c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ce40>, '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': '31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312', '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 22:00: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 22:00: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 mozsystemmonitor==0.3 22:00:49 INFO - Using env: {'DISPLAY': ':0', 22:00:49 INFO - 'HOME': '/home/cltbld', 22:00:49 INFO - 'LANG': 'en_US.UTF-8', 22:00:49 INFO - 'LANGUAGE': 'en_US:en', 22:00:49 INFO - 'LOGNAME': 'cltbld', 22:00:49 INFO - 'MAIL': '/var/mail/cltbld', 22:00:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:49 INFO - 'MOZ_NO_REMOTE': '1', 22:00:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:49 INFO - 'NO_EM_RESTART': '1', 22:00:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:49 INFO - 'PWD': '/builds/slave/test', 22:00:49 INFO - 'SHELL': '/bin/bash', 22:00:49 INFO - 'SHLVL': '1', 22:00:49 INFO - 'TERM': 'linux', 22:00:49 INFO - 'TMOUT': '86400', 22:00:49 INFO - 'USER': 'cltbld', 22:00:49 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312', 22:00:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:49 INFO - '_': '/tools/buildbot/bin/python'} 22:00:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:00:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:00:51 INFO - Installing collected packages: mozsystemmonitor 22:00:51 INFO - Running setup.py install for mozsystemmonitor 22:00:51 INFO - Successfully installed mozsystemmonitor 22:00:51 INFO - Cleaning up... 22:00:51 INFO - Return code: 0 22:00:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:00:51 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')]} 22:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:51 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')]} 22:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:51 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 0x7f11f967df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29090>, '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 0x2b2c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ce40>, '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': '31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312', '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 22:00:51 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 22:00:51 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 22:00:51 INFO - Using env: {'DISPLAY': ':0', 22:00:51 INFO - 'HOME': '/home/cltbld', 22:00:51 INFO - 'LANG': 'en_US.UTF-8', 22:00:51 INFO - 'LANGUAGE': 'en_US:en', 22:00:51 INFO - 'LOGNAME': 'cltbld', 22:00:51 INFO - 'MAIL': '/var/mail/cltbld', 22:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:51 INFO - 'MOZ_NO_REMOTE': '1', 22:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:51 INFO - 'NO_EM_RESTART': '1', 22:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:51 INFO - 'PWD': '/builds/slave/test', 22:00:51 INFO - 'SHELL': '/bin/bash', 22:00:51 INFO - 'SHLVL': '1', 22:00:51 INFO - 'TERM': 'linux', 22:00:51 INFO - 'TMOUT': '86400', 22:00:51 INFO - 'USER': 'cltbld', 22:00:51 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312', 22:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:51 INFO - '_': '/tools/buildbot/bin/python'} 22:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:51 INFO - Downloading/unpacking jsonschema==2.5.1 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:00:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:00:53 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 22:00:53 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 22:00:53 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 22:00:53 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 22:00:53 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 22:00:53 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 22:00:53 INFO - Downloading functools32-3.2.3-2.tar.gz 22:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:00:54 INFO - warning: no files found matching '*.txt' 22:00:54 INFO - no previously-included directories found matching 'build' 22:00:54 INFO - no previously-included directories found matching 'dist' 22:00:54 INFO - no previously-included directories found matching '.git*' 22:00:54 INFO - Installing collected packages: jsonschema, functools32 22:00:54 INFO - Running setup.py install for functools32 22:00:54 INFO - warning: no files found matching '*.txt' 22:00:54 INFO - no previously-included directories found matching 'build' 22:00:54 INFO - no previously-included directories found matching 'dist' 22:00:54 INFO - no previously-included directories found matching '.git*' 22:00:54 INFO - Successfully installed jsonschema functools32 22:00:54 INFO - Cleaning up... 22:00:54 INFO - Return code: 0 22:00:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:00:54 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')]} 22:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:54 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')]} 22:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:54 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 0x7f11f967df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29090>, '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 0x2b2c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ce40>, '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': '31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312', '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 22:00:54 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 22:00:54 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 22:00:54 INFO - Using env: {'DISPLAY': ':0', 22:00:54 INFO - 'HOME': '/home/cltbld', 22:00:54 INFO - 'LANG': 'en_US.UTF-8', 22:00:54 INFO - 'LANGUAGE': 'en_US:en', 22:00:54 INFO - 'LOGNAME': 'cltbld', 22:00:54 INFO - 'MAIL': '/var/mail/cltbld', 22:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:54 INFO - 'MOZ_NO_REMOTE': '1', 22:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:54 INFO - 'NO_EM_RESTART': '1', 22:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:54 INFO - 'PWD': '/builds/slave/test', 22:00:54 INFO - 'SHELL': '/bin/bash', 22:00:54 INFO - 'SHLVL': '1', 22:00:54 INFO - 'TERM': 'linux', 22:00:54 INFO - 'TMOUT': '86400', 22:00:54 INFO - 'USER': 'cltbld', 22:00:54 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312', 22:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:54 INFO - '_': '/tools/buildbot/bin/python'} 22:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:00:54 INFO - Cleaning up... 22:00:54 INFO - Return code: 0 22:00:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:00:54 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')]} 22:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:54 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')]} 22:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:54 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 0x7f11f967df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29090>, '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 0x2b2c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ce40>, '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': '31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312', '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 22:00:54 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 22:00:54 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 22:00:54 INFO - Using env: {'DISPLAY': ':0', 22:00:54 INFO - 'HOME': '/home/cltbld', 22:00:54 INFO - 'LANG': 'en_US.UTF-8', 22:00:54 INFO - 'LANGUAGE': 'en_US:en', 22:00:54 INFO - 'LOGNAME': 'cltbld', 22:00:54 INFO - 'MAIL': '/var/mail/cltbld', 22:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:54 INFO - 'MOZ_NO_REMOTE': '1', 22:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:54 INFO - 'NO_EM_RESTART': '1', 22:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:54 INFO - 'PWD': '/builds/slave/test', 22:00:54 INFO - 'SHELL': '/bin/bash', 22:00:54 INFO - 'SHLVL': '1', 22:00:54 INFO - 'TERM': 'linux', 22:00:54 INFO - 'TMOUT': '86400', 22:00:54 INFO - 'USER': 'cltbld', 22:00:54 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312', 22:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:54 INFO - '_': '/tools/buildbot/bin/python'} 22:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:54 INFO - Downloading/unpacking blobuploader==1.2.4 22:00:54 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 22:00:54 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 22:00:54 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 22:00:54 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 22:00:54 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 22:00:54 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 22:00:56 INFO - Downloading blobuploader-1.2.4.tar.gz 22:00:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:00:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00: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 22:00:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:00:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:00:57 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 22:00:57 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 22:00:57 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 22:00:57 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 22:00:57 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 22:00:57 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 22:00:57 INFO - Downloading docopt-0.6.1.tar.gz 22:00:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:00:57 INFO - Installing collected packages: blobuploader, requests, docopt 22:00:57 INFO - Running setup.py install for blobuploader 22:00:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:00:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:00:57 INFO - Running setup.py install for requests 22:00:57 INFO - Running setup.py install for docopt 22:00:57 INFO - Successfully installed blobuploader requests docopt 22:00:57 INFO - Cleaning up... 22:00:57 INFO - Return code: 0 22:00:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:00: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')]} 22:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00: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')]} 22:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00: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 0x7f11f967df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29090>, '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 0x2b2c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ce40>, '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': '31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312', '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 22:00: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 22:00: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 22:00:57 INFO - Using env: {'DISPLAY': ':0', 22:00:57 INFO - 'HOME': '/home/cltbld', 22:00:57 INFO - 'LANG': 'en_US.UTF-8', 22:00:57 INFO - 'LANGUAGE': 'en_US:en', 22:00:57 INFO - 'LOGNAME': 'cltbld', 22:00:57 INFO - 'MAIL': '/var/mail/cltbld', 22:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:57 INFO - 'MOZ_NO_REMOTE': '1', 22:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:00:57 INFO - 'NO_EM_RESTART': '1', 22:00:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:57 INFO - 'PWD': '/builds/slave/test', 22:00:57 INFO - 'SHELL': '/bin/bash', 22:00:57 INFO - 'SHLVL': '1', 22:00:57 INFO - 'TERM': 'linux', 22:00:57 INFO - 'TMOUT': '86400', 22:00:57 INFO - 'USER': 'cltbld', 22:00:57 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312', 22:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:57 INFO - '_': '/tools/buildbot/bin/python'} 22:00:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:00:58 INFO - Running setup.py (path:/tmp/pip-l6vTLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:00:58 INFO - Running setup.py (path:/tmp/pip-AxwM0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:00:58 INFO - Running setup.py (path:/tmp/pip-4jYL0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:00:58 INFO - Running setup.py (path:/tmp/pip-ZkhvFb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:00:58 INFO - Running setup.py (path:/tmp/pip-_pYYeA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:00:58 INFO - Running setup.py (path:/tmp/pip-7kuUib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:00:58 INFO - Running setup.py (path:/tmp/pip-0pqxyD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:00:58 INFO - Running setup.py (path:/tmp/pip-j5_jZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:00:58 INFO - Running setup.py (path:/tmp/pip-ndR5EC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:00:58 INFO - Running setup.py (path:/tmp/pip-0oVTKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:00:58 INFO - Running setup.py (path:/tmp/pip-gdApHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:00:58 INFO - Running setup.py (path:/tmp/pip-42lCeR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:00:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:00:58 INFO - Running setup.py (path:/tmp/pip-4uZzhy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:00:59 INFO - Running setup.py (path:/tmp/pip-Sfjo9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:59 INFO - Running setup.py (path:/tmp/pip-fLyHhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:00:59 INFO - Running setup.py (path:/tmp/pip-QnCj0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:00:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:00:59 INFO - Running setup.py (path:/tmp/pip-RhMDxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:00:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:00:59 INFO - Running setup.py install for manifestparser 22:00:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:00:59 INFO - Running setup.py install for mozcrash 22:00:59 INFO - Running setup.py install for mozdebug 22:00:59 INFO - Running setup.py install for mozdevice 22:00:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:00:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:00:59 INFO - Running setup.py install for mozfile 22:00:59 INFO - Running setup.py install for mozhttpd 22:00:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:00:59 INFO - Running setup.py install for mozinfo 22:01:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:01:00 INFO - Running setup.py install for mozInstall 22:01:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:01:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:01:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:01:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:01:00 INFO - Running setup.py install for mozleak 22:01:00 INFO - Running setup.py install for mozlog 22:01:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:01:00 INFO - Running setup.py install for moznetwork 22:01:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:01:00 INFO - Running setup.py install for mozprocess 22:01:00 INFO - Running setup.py install for mozprofile 22:01:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:01:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:01:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:01:00 INFO - Running setup.py install for mozrunner 22:01:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:01:00 INFO - Running setup.py install for mozscreenshot 22:01:00 INFO - Running setup.py install for moztest 22:01:01 INFO - Running setup.py install for mozversion 22:01:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:01:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:01:01 INFO - Cleaning up... 22:01:01 INFO - Return code: 0 22:01:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 22:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:01 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 0x7f11f967df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29090>, '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 0x2b2c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ce40>, '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': '31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312', '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 22:01:01 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 22:01:01 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 22:01:01 INFO - Using env: {'DISPLAY': ':0', 22:01:01 INFO - 'HOME': '/home/cltbld', 22:01:01 INFO - 'LANG': 'en_US.UTF-8', 22:01:01 INFO - 'LANGUAGE': 'en_US:en', 22:01:01 INFO - 'LOGNAME': 'cltbld', 22:01:01 INFO - 'MAIL': '/var/mail/cltbld', 22:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:01 INFO - 'MOZ_NO_REMOTE': '1', 22:01:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:01 INFO - 'NO_EM_RESTART': '1', 22:01:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:01 INFO - 'PWD': '/builds/slave/test', 22:01:01 INFO - 'SHELL': '/bin/bash', 22:01:01 INFO - 'SHLVL': '1', 22:01:01 INFO - 'TERM': 'linux', 22:01:01 INFO - 'TMOUT': '86400', 22:01:01 INFO - 'USER': 'cltbld', 22:01:01 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312', 22:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:01 INFO - '_': '/tools/buildbot/bin/python'} 22:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:01:01 INFO - Running setup.py (path:/tmp/pip-A7v2V4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:01:01 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)) 22:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:01:01 INFO - Running setup.py (path:/tmp/pip-RY1VAY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:01:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 22:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:01:01 INFO - Running setup.py (path:/tmp/pip-magKsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:01:01 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)) 22:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:01:01 INFO - Running setup.py (path:/tmp/pip-itBlAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:01:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 22:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:01:01 INFO - Running setup.py (path:/tmp/pip-inpfxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:01:01 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)) 22:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:01:01 INFO - Running setup.py (path:/tmp/pip-L277Mp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:01: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)) 22:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:01:01 INFO - Running setup.py (path:/tmp/pip-pb7O1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:01: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)) 22:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:01:01 INFO - Running setup.py (path:/tmp/pip-j6VwHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:01: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)) 22:01:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:01:01 INFO - Running setup.py (path:/tmp/pip-hn3v45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:01:02 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)) 22:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:01:02 INFO - Running setup.py (path:/tmp/pip-TLskJZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:01:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 22:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:01:02 INFO - Running setup.py (path:/tmp/pip-PZdaJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:01:02 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)) 22:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:01:02 INFO - Running setup.py (path:/tmp/pip-geaGT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:01:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 22:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:01:02 INFO - Running setup.py (path:/tmp/pip-ha5RuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:01:02 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)) 22:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:01:02 INFO - Running setup.py (path:/tmp/pip-XJdDN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:01:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 22:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:02 INFO - Running setup.py (path:/tmp/pip-pA_YyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:01:02 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)) 22:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:01:02 INFO - Running setup.py (path:/tmp/pip-wPO4aZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:01:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 22:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:01:02 INFO - Running setup.py (path:/tmp/pip-oxHwLM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:01:02 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)) 22:01:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:01:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:01:02 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)) 22:01:02 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:01:02 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:01:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:01:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:01:04 INFO - Downloading blessings-1.6.tar.gz 22:01:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:01:04 INFO - Installing collected packages: blessings 22:01:04 INFO - Running setup.py install for blessings 22:01:04 INFO - Successfully installed blessings 22:01:04 INFO - Cleaning up... 22:01:04 INFO - Return code: 0 22:01:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:01:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:01:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:01:04 INFO - Reading from file tmpfile_stdout 22:01:04 INFO - Current package versions: 22:01:04 INFO - argparse == 1.2.1 22:01:04 INFO - blessings == 1.6 22:01:04 INFO - blobuploader == 1.2.4 22:01:04 INFO - docopt == 0.6.1 22:01:04 INFO - functools32 == 3.2.3-2 22:01:04 INFO - jsonschema == 2.5.1 22:01:04 INFO - manifestparser == 1.1 22:01:04 INFO - mozInstall == 1.12 22:01:04 INFO - mozcrash == 0.17 22:01:04 INFO - mozdebug == 0.1 22:01:04 INFO - mozdevice == 0.48 22:01:04 INFO - mozfile == 1.2 22:01:04 INFO - mozhttpd == 0.7 22:01:04 INFO - mozinfo == 0.9 22:01:04 INFO - mozleak == 0.1 22:01:04 INFO - mozlog == 3.3 22:01:04 INFO - moznetwork == 0.27 22:01:04 INFO - mozprocess == 0.23 22:01:04 INFO - mozprofile == 0.28 22:01:04 INFO - mozrunner == 6.12 22:01:04 INFO - mozscreenshot == 0.1 22:01:04 INFO - mozsystemmonitor == 0.3 22:01:04 INFO - moztest == 0.7 22:01:04 INFO - mozversion == 1.4 22:01:04 INFO - psutil == 3.1.1 22:01:04 INFO - requests == 1.2.3 22:01:04 INFO - wsgiref == 0.1.2 22:01:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:01: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')]} 22:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:05 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')]} 22:01:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:05 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 0x7f11f967df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29090>, '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 0x2b2c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ce40>, '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': '31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312', '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 22:01:05 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 22:01:05 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 22:01:05 INFO - Using env: {'DISPLAY': ':0', 22:01:05 INFO - 'HOME': '/home/cltbld', 22:01:05 INFO - 'LANG': 'en_US.UTF-8', 22:01:05 INFO - 'LANGUAGE': 'en_US:en', 22:01:05 INFO - 'LOGNAME': 'cltbld', 22:01:05 INFO - 'MAIL': '/var/mail/cltbld', 22:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:05 INFO - 'MOZ_NO_REMOTE': '1', 22:01:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:05 INFO - 'NO_EM_RESTART': '1', 22:01:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:05 INFO - 'PWD': '/builds/slave/test', 22:01:05 INFO - 'SHELL': '/bin/bash', 22:01:05 INFO - 'SHLVL': '1', 22:01:05 INFO - 'TERM': 'linux', 22:01:05 INFO - 'TMOUT': '86400', 22:01:05 INFO - 'USER': 'cltbld', 22:01:05 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312', 22:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:05 INFO - '_': '/tools/buildbot/bin/python'} 22:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:05 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)) 22:01:05 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)) 22:01:05 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)) 22:01:05 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)) 22:01:05 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)) 22:01:05 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)) 22:01:05 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)) 22:01:05 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)) 22:01:05 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)) 22:01:05 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)) 22:01:05 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)) 22:01:05 INFO - Cleaning up... 22:01:05 INFO - Return code: 0 22:01:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:01:05 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')]} 22:01:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:01:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:05 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')]} 22:01:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:01:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:01:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7f11f967df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2f230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b29090>, '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 0x2b2c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ce40>, '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': '31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312', '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 22:01:05 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 22:01:05 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 22:01:05 INFO - Using env: {'DISPLAY': ':0', 22:01:05 INFO - 'HOME': '/home/cltbld', 22:01:05 INFO - 'LANG': 'en_US.UTF-8', 22:01:05 INFO - 'LANGUAGE': 'en_US:en', 22:01:05 INFO - 'LOGNAME': 'cltbld', 22:01:05 INFO - 'MAIL': '/var/mail/cltbld', 22:01:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:05 INFO - 'MOZ_NO_REMOTE': '1', 22:01:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:05 INFO - 'NO_EM_RESTART': '1', 22:01:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:05 INFO - 'PWD': '/builds/slave/test', 22:01:05 INFO - 'SHELL': '/bin/bash', 22:01:05 INFO - 'SHLVL': '1', 22:01:05 INFO - 'TERM': 'linux', 22:01:05 INFO - 'TMOUT': '86400', 22:01:05 INFO - 'USER': 'cltbld', 22:01:05 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312', 22:01:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:05 INFO - '_': '/tools/buildbot/bin/python'} 22:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:01:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:01:05 INFO - Cleaning up... 22:01:05 INFO - Return code: 0 22:01:05 INFO - Running post-action listener: _resource_record_post_action 22:01:05 INFO - Running post-action listener: _start_resource_monitoring 22:01:05 INFO - Starting resource monitoring. 22:01:05 INFO - [mozharness: 2016-08-13 05:01:05.470276Z] Finished create-virtualenv step (success) 22:01:05 INFO - [mozharness: 2016-08-13 05:01:05.470792Z] Running install step. 22:01:05 INFO - Running pre-action listener: _resource_record_pre_action 22:01:05 INFO - Running main action method: install 22:01:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:01:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:01:05 INFO - Reading from file tmpfile_stdout 22:01:05 INFO - Detecting whether we're running mozinstall >=1.0... 22:01:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:01:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:01:05 INFO - Reading from file tmpfile_stdout 22:01:05 INFO - Output received: 22:01:05 INFO - Usage: mozinstall [options] installer 22:01:05 INFO - Options: 22:01:05 INFO - -h, --help show this help message and exit 22:01:05 INFO - -d DEST, --destination=DEST 22:01:05 INFO - Directory to install application into. [default: 22:01:05 INFO - "/builds/slave/test"] 22:01:05 INFO - --app=APP Application being installed. [default: firefox] 22:01:05 INFO - mkdir: /builds/slave/test/build/application 22:01:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:01:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:01:21 INFO - Reading from file tmpfile_stdout 22:01:21 INFO - Output received: 22:01:21 INFO - /builds/slave/test/build/application/firefox/firefox 22:01:21 INFO - Running post-action listener: _resource_record_post_action 22:01:21 INFO - [mozharness: 2016-08-13 05:01:21.787216Z] Finished install step (success) 22:01:21 INFO - [mozharness: 2016-08-13 05:01:21.787556Z] Running run-tests step. 22:01:21 INFO - Running pre-action listener: _resource_record_pre_action 22:01:21 INFO - Running main action method: run_tests 22:01:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:01:21 INFO - Python 2.7.3 22:01:21 INFO - Return code: 0 22:01:21 INFO - grabbing minidump binary from tooltool 22:01: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')]} 22:01: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 0x2b29090>, '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 0x2b2c9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b2ce40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:01: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 22:01: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 22:01: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 22:01:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:01:21 INFO - Return code: 0 22:01:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:01:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:01:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:01:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:01:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:01:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RK3EDr6jRZmg9dx--b-nYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 22:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RK3EDr6jRZmg9dx--b-nYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 22:01:21 INFO - Using env: {'DISPLAY': ':0', 22:01:21 INFO - 'HOME': '/home/cltbld', 22:01:21 INFO - 'LANG': 'en_US.UTF-8', 22:01:21 INFO - 'LANGUAGE': 'en_US:en', 22:01:21 INFO - 'LOGNAME': 'cltbld', 22:01:21 INFO - 'MAIL': '/var/mail/cltbld', 22:01:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:01:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:01:21 INFO - 'MOZ_NO_REMOTE': '1', 22:01:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:01:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:01:21 INFO - 'NO_EM_RESTART': '1', 22:01:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:01:21 INFO - 'PWD': '/builds/slave/test', 22:01:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:01:21 INFO - 'SHELL': '/bin/bash', 22:01:21 INFO - 'SHLVL': '1', 22:01:21 INFO - 'TERM': 'linux', 22:01:21 INFO - 'TMOUT': '86400', 22:01:21 INFO - 'USER': 'cltbld', 22:01:21 INFO - 'XDG_SESSION_COOKIE': '31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312', 22:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:01:21 INFO - '_': '/tools/buildbot/bin/python'} 22:01:21 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RK3EDr6jRZmg9dx--b-nYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 22:01:22 INFO - mozversion application_buildid: 20160812212417 22:01:22 INFO - mozversion application_changeset: b17f42ecbc3cb0c36ca7215762c5f972722c8321 22:01:22 INFO - mozversion application_display_name: Nightly 22:01:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:01:22 INFO - mozversion application_name: Firefox 22:01:22 INFO - mozversion application_remotingname: firefox 22:01:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 22:01:22 INFO - mozversion application_vendor: Mozilla 22:01:22 INFO - mozversion application_version: 51.0a1 22:01:22 INFO - mozversion platform_buildid: 20160812212417 22:01:22 INFO - mozversion platform_changeset: b17f42ecbc3cb0c36ca7215762c5f972722c8321 22:01:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 22:01:22 INFO - mozversion platform_version: 51.0a1 22:01:22 INFO - using testdate: 1471064482 22:01:22 INFO - actual date: 1471064482 22:01:22 INFO - starting webserver on 'localhost:48609' 22:01:22 INFO - SUITE-START | Running 2 tests 22:01:22 INFO - TEST-START | dromaeo_css 22:01:22 INFO - operating with platform_type : linux_ 22:01:22 INFO - Initialising browser for dromaeo_css test... 22:01:22 INFO - TEST-INFO | started process 22789 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfp4J3o/profile http://localhost:48609/getInfo.html) 22:01:26 INFO - PROCESS | 22789 | __metrics Screen width/height:1600/1200 22:01:26 INFO - PROCESS | 22789 | colorDepth:24 22:01:26 INFO - PROCESS | 22789 | Browser inner width/height: 1024/697 22:01:26 INFO - PROCESS | 22789 | __metrics 22:01:27 ERROR - PROCESS | 22789 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 22:01:28 INFO - TEST-INFO | 22789: exit 0 22:01:28 INFO - Browser initialized. 22:01:28 INFO - Running cycle 1/1 for dromaeo_css test... 22:01:28 INFO - TEST-INFO | started process 22913 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfp4J3o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:01:40 INFO - PROCESS | 22913 | RSS: Main: 163962880 22:01:40 INFO - PROCESS | 22913 | 22:02:29 INFO - PROCESS | 22913 | 1471064549970 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:04:43 INFO - PROCESS | 22913 | Cycle 1(1): loaded http://localhost:48609/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48609/tests/dromaeo/cssquery-ext.html) 22:04:44 INFO - PROCESS | 22913 | RSS: Main: 165093376 22:04:44 INFO - PROCESS | 22913 | 22:07:46 INFO - PROCESS | 22913 | Cycle 1(1): loaded http://localhost:48609/tests/dromaeo/cssquery-ext.html (next: http://localhost:48609/tests/dromaeo/cssquery-jquery.html) 22:07:47 INFO - PROCESS | 22913 | RSS: Main: 164696064 22:07:47 INFO - PROCESS | 22913 | 22:10:49 INFO - PROCESS | 22913 | Cycle 1(1): loaded http://localhost:48609/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48609/tests/dromaeo/cssquery-mootools.html) 22:10:49 INFO - PROCESS | 22913 | RSS: Main: 166064128 22:10:49 INFO - PROCESS | 22913 | 22:13:51 INFO - PROCESS | 22913 | Cycle 1(1): loaded http://localhost:48609/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48609/tests/dromaeo/cssquery-prototype.html) 22:13:52 INFO - PROCESS | 22913 | RSS: Main: 163921920 22:13:52 INFO - PROCESS | 22913 | 22:16:55 INFO - PROCESS | 22913 | Cycle 1(1): loaded http://localhost:48609/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48609/tests/dromaeo/cssquery-yui.html) 22:16:56 INFO - PROCESS | 22913 | RSS: Main: 166170624 22:16:56 INFO - PROCESS | 22913 | 22:19:58 INFO - PROCESS | 22913 | Cycle 1(1): loaded http://localhost:48609/tests/dromaeo/cssquery-yui.html (next: http://localhost:48609/tests/dromaeo/cssquery-dojo.html) 22:19:58 INFO - PROCESS | 22913 | RSS: Main: 165793792 22:19:58 INFO - PROCESS | 22913 | 22:19:58 INFO - PROCESS | 22913 | __start_tp_report 22:19:58 INFO - PROCESS | 22913 | _x_x_mozilla_page_load 22:19:58 INFO - PROCESS | 22913 | _x_x_mozilla_page_load_details 22:19:58 INFO - PROCESS | 22913 | |i|pagename|runs| 22:19:58 INFO - PROCESS | 22913 | |0;dojo.html;2692.8115031947764;2720.034387792334;2727.7681397081246;2740.3423178437183;2746.340878189234;4759.833405830796;4842.201036828923;4846.345743324655;4896.8041278348865;4936;4873;4880.365552478182;4967.975160124194;5000.0999820032375;5035.169197082477;4505.144022635697;4539.160255352754;4563.726176429408;4581.67928245023;4639.304104384352;4578.839740609079;4579.175748365293;4579.885502862422;4594.173048851206;4599.4710608279975;4393.143337049277;4432;4469.039156581318;4469.9776501117285;4569.268916973285;4374.737515749065;4424.60178583929;4430.224710675619;4450.777461126931;4548.295014272793;4467.530909254514;4484.8206071757095;4491.483479399878;4500.054988452429;4526.207913615104;4816.205326121186;4844.563989240985;4851.684640498356;4922;4925.827596034122;5221.817236396708;5243.239730239132;5244.39689435716;5290.285811415487;5303.231031500411;5272.3200702311005;5281.551068159172;5299.629025968184;5304.2839216706025;5321.042212401805;4697.600703940135;4817.470078291385;4870.878228044327;4871.050145221719;4910.975445122787;5366;5388.461153884658;5401.5948803839865;5416.83749487516;5435.184722291688;5115.514026167508;5161.74191290434;5163.7676304566385;5188.9740551297;5218;5027.899442011139;5128.435872054071;5166.044281807877;5184.040952423814;5246.186841039568;5161.354830646169;5171.81898633546;5173.482651734872;5174.094533456705;5199.168133098686;5159.071367153873;5163.483651634807;5165.509276618715;5169.379674439091;5215.087359712035;4319.8488052918;4384.934225986613;4405.427294451701;4425.933610995838;4435.778211089432;3868.2263547290654;3871.3612253977776;3874.612538746103;3913.099987002948;3923.843046278174;4542.432195975503;4547.704399214107;4556.270996640522;4557.1797076526545;4588.105319462739;5086.16078347076;5161.148410512298;5189.948100518946;5221.7128057956415;5297.682139071668;4512.210363186429;4537.02453972391;4563.748993805372;4577.0845830833305;4580.152671755736;4728.361671174416;4735.2186889163595;4738.3840100787365;4751.168545504523;4778.928316075262;4725.36207611968;4817.807287708452;4819.614430845454;4905.166121759238;4913.066517361762;5227.790888364423;5227.973860130675;5236.423993360803;5268.947310526845;5283.920741188808;4826.686265392878;4839.612830973584;4842.58837998774;4857.708537487762;4907.33750943618;5023.974880125576;5096.420109765836;5110.054639891632;5122.462141475092;5164.3802743671;5212.869678258074;5242.737863106906;5258.526732594085;5260;5270.60470464709;5097.617678674188;5102.107131251942;5110.616703747308;5111.539961403491;5162.09663308927;4908.779104940358;5023.924641130459;5047.2429135629945;5086.440491545853;5088.414832294334;4946.678465899705;4960.677555958851;4990.50094990498;5009.148444764326;5027.5475207230065;5162.380514338303;5176.301199338041;5189.948100518946;5192.532672059533;5222.634415590872;4884.780184891617;4979.0788704089855;5001.199808030698;5029;5056 22:19:58 INFO - PROCESS | 22913 | |1;ext.html;507.79688124750106;520.146958987261;521.7339157029916;525.3249574297029;550.0676353580683;34895.476567851474;38653.80673096631;38694.41958370623;38730.61269387305;38863;38365.820614217075;38653;38700.225995480076;38829.80585097078;38840.61159388405;7485.812854678622;7509.511881727698;7594.696212151507;7604.619769011555;7626.656800443966;7604.543727376347;7632.771016869475;7650.120236172828;7684.65419056141;7734.419918506106;7655.655495502688;7672.884906726404;7707.30634242918;7724.459287849852;7727.574983375912;7646.502977306485;7664.425168112414;7665.770026899202;7704.383649308098;7707.075150981862;7446.776596702053;7469.253074692541;7497.5126616770285;7514.135874374462;7523.172451030437;36184;36236.63763362359;36294.27411451756;36620.26759464823;36620.450693239625;2329.988350058256;2955.5123404638207;3023.486007378729;3059.464593696094;3123.2191952012;27171.86414067937;27599.31001724953;27705.86147069272;27742.3064423389;27780.58329125065;3198.9040328790174;3244.691754283363;3270.787398819093;3349.3133907548895;3441.380551500729;218124;218715;219355;220353.89823050943;220417;27583.172504824888;28326.43347133087;30849;31022.689773102433;31118.377632447224;32462.350752984807;32579.837100814344;32659;32697.50953735696;32724.18189545233;11191.72020699489;11230.157738169506;11241.381724005258;11267.830982535268;11303.491342889589;9678.17735492477;9709.757256068655;9721.076497732704;9745.902540974641;9778.804423911482;7656.310932016146;7668.501547399401;7752.806179845549;7798.727044553527;7822.335101516321;3042.543618457205;3051.404976029653;3079.384123175374;3085.4291955988215;3132.420502207099;856.5631527920681;878.9384743068051;971.9416834989923;989.6585677941099;999.3404353127047;26915.596266056025;27459.450810983668;27691.584626230622;28251.717482824908;28377.148685539465;915.3180880244128;970.1075010989906;971.8629203831534;1014.1177175857051;1017.0693815159046;13974.441022358991;14584.854151458561;14608.561743147722;14631;14710.705785884222;384586;388567;389625;391685;392345;47737.76131119322;47800;48182.518174818506;48289;48303;1170.309517384747;1201.069171392178;1204.740980689156;1210.3040751567883;1210.9212901161397;25351.239462816146;26599.86700066487;27451.588226176224;27687.30781730473;27934.02230921908;41117.1776564461;41593;41781.58218417777;41904.58095419007;41937.79031104947;286739;288157;288615;289452;289540.2551693726;24486.87756561206;24807.25578232656;24827.255182344557;24849.875750621854;24918.626220606344;39798.801005994785;39993.2001359977;40317.39523907085;40665.186696265315;41454.1709165821;34407.65592344045;34810.82594587011;34970;35460.64539354573;36023;34799.826000869834;34873;35100.82449587736;35146.47280290747;35417.82291088528;34496.48255276123;34847.825760872045;35291.647083528835;36496.45255321226;36666;30207;32439.675603243664;33797;33993.490097649046;34048;25137.371565711004;25146;25480.490390192463;26046;26161.73838261593 22:19:58 INFO - PROCESS | 22913 | |2;jquery.html;362.9600743918167;368.52276302188665;372.67018688460706;383.5662720041337;391.6044794757296;15819.683606327866;16254.75617865733;17108.144592770357;17121.57196070099;17144.31422743089;16358.83641163588;16855.831441685612;17167.484975450727;17286;17365.218565164567;4950.727709975949;5222.5038621331105;5224.947750522503;5225.947740522584;5226.5818734501145;4988.575971042447;5128.205128205134;5132.8460146195675;5191.169412893938;5198.948010519903;5135.2297155426795;5138.537531622153;5146.897062058757;5151.124308867483;5163.509466600685;4959.429665588467;5089.567386772129;5110.131277682803;5125.564327032188;5157.329547158883;4610.5389461053965;4619.12236675034;4628.375169352128;4633.86098417048;4641.628669706415;20311.79688203114;20701.378958631267;20997.475063123544;21008.684869726967;21066.157353705832;2089.2583132987725;2119.618468675638;2326.220716060122;2337.3104934044327;2544.4783819316995;12640.55758048473;13420.597382078455;13605.183688978694;13968.930155349159;14147.221902795342;1739.5303268117664;1793.8116497767808;1855.6845336292727;1860.8046155153784;1864.85039557432;66522;66658;66709;67196;67982;9680.225581953428;9701.563429645541;9770.36200225935;9899.752506187258;10135.7466063349;13412.865871341162;13449.529266475627;13457.327133643279;13484.460621575026;13523;6609.735610575619;6626.56927299724;6812.489063320171;6837.62393068386;6996.440284777307;6035.758569657252;6191.380861913863;6302.810915672446;6304.369563043659;6331.271903731038;6068.302145253352;6115.785947491817;6116.816495505142;6247.718852651642;6396.168498095218;1782.349442453521;1832.395309547846;1845.5201647571728;1850.8334249917302;1856.5915498590289;846.3398549131687;883.823235352932;891.6567121658209;940.7177846645978;1007.496251874063;17310;18169.36407225741;18500.722489162672;18584.81415185858;18696;855.2114134384735;885.7874110213502;892.5492626223715;906;922.6932668329177;10047.296689231829;10217.33587316822;10451;10523.368597884151;10535.683929482127;160987;163351.18324408302;374780;374868;375776;78336.51644384953;78699;81684.59157704173;83120.58439707763;84509.57745211235;915.5330781301584;944.1031020530523;945.7304668169538;958.1472489484364;959.9376040557341;14946.402143914122;15769.44806931752;15913.920430398237;16214.837851621332;16708.749368759236;37311;38018.42972355472;39014.804925975186;40002.59997399989;41284.79357603193;46276.7686161567;48068.759656201495;51108.56708643181;51891.740541297055;52238.21642675439;7476.514026588255;7621.35218506411;7731.9613401934885;7900;8012.158723334199;10439.425831579032;12149.331786751813;12390;12502.374691290073;12807.743845123232;10248.231382646181;10384.221183411426;10424.85326614087;10451.007154320327;10587.100096491577;10519.737006574896;10926.72683182895;10983.725406864893;10992.120630349713;11205.103591712807;10523.894761052597;10687.412192329186;10750.73123171927;10784.514696838818;10821.835632873299;7614.657340419805;7753.689852405841;7754.7673569793;7784.455088144002;7925.722599708983;9947.204223662235;10551.683449496528;10672.466376680979;10866.728331791768;11244.775104498029 22:19:58 INFO - PROCESS | 22913 | |3;mootools.html;1368.664677154097;1382.191418020458;1445.8120444342235;1647.1928754910098;1694.313802909822;6713.966430167842;7439.59082250476;7499.362554182894;8159.632816523256;8166.836663266731;7584.393248540117;7888.934993775839;7889.842203155948;7925.603719814015;7938.603069846514;2163.2212403534713;2194.1333173396497;2196.967045494319;2200.273909609825;2206.9779302206935;2144.957100857982;2193.56128774245;2221.5112675211426;2229.208630936019;2239.664050392446;2193.3419974007816;2196.1983875885267;2198.835087368454;2210.834187435949;2229.6209644360415;2145.4850835799375;2155.655095184763;2156.493224092337;2158.125958986613;2164.210063326874;2099.7060411542398;2140.2188201306567;2156.687280344341;2157.5792720419527;2159.4601349662585;7673.155952845183;7807.882881756778;7839.843203135905;7844.450888437812;7853.136155022943;4470.552944705536;4579.244424669925;4605.5854973052255;4611.930821037688;4643.16423043852;2889.2343528964843;3029.3032602501326;3044;3051;3052.465818481779;885.9335549833788;944.0512285153445;959.6545243712258;960.1358777100595;977.4819345746765;10795.514201860935;10886.945565272123;10960.890391096067;10966.506507207196;11003.33979961197;4023.91952160961;4166.91666166681;4300.16146851361;4313.870583882489;4337.566243375637;9110.498922559324;9130.680426185185;9135;9136.040715724754;9147.131022552847;4525.434320709911;4556.977215113903;4558.407407037131;4566.4748553916725;4576.153411618795;3692.630736926286;3963.9009024774036;4057.16828050249;4167;4168.499780026416;3611.422172452395;3658.451232315174;3693.7229707772026;3710.870119545803;3783.1109689223013;1249.6188662458037;1250.1061740855332;1255.4852510470664;1260.4580030586935;1262.8042653388738;795.9840803183904;812.6668066092874;821.6220538552333;823.3331001888489;824.1058451579983;4830.782614782343;4927.90144197114;4992.850214493571;5218.6868787872845;5274.393444753826;397.6321902240416;875.4222213339166;875.746033650247;910.4869470451359;934.5934518484481;3533.293341331744;3551.1654761131113;3624.9818750906074;3630.567519761766;3638.8180590970874;9395.107464790834;9750.561224744763;9835.803283934281;9878.851817222747;9914.256430767722;9745.512724363753;9756.463394513228;9769.218462522982;9770;9779.119879210763;7164.104486939133;7198.89201661965;7206.387457066208;7216.35052845236;7263.527870688388;4761.476237613929;4825.324454576292;4834.709917404967;4860.878478038077;4870.659053866196;8491.617877195418;8663.306935445024;8727.127287271222;8761.780955476164;8780.121987801169;8709.695160669346;8718.302535797247;8835.160659737314;8843.115688431106;8909.064548222343;5762.366139724543;6244.250689917239;6316.715747791269;6411.166548348685;6460.3862633049785;7688.308052275322;7748.302652761278;7750.728724494616;7757.069151701832;7777.57223352721;6744.258131605618;6813.693383797642;6839.213490448463;6841.418479429105;7027.15674119109;6362.109304697438;6396.264429590657;6464.159659244457;6572.572782769296;6976.7558135465015;6267.4986001120715;6341.8097457076365;6359.109724638647;6364.331745166691;6380;4257.5529569396;4469.687121901436;4551.089782043538;4560.6807523473035;4567.840125595588;4368.825246990212;4386.561343865588;4474.507804141476;4521.434820647419;4604.815807367668 22:19:58 INFO - PROCESS | 22913 | |4;prototype.html;290.4061194856518;294.81721332773685;301.1747810997865;301.874721990374;302.3710681781894;5007.624428167888;5113.821016264432;5125.923111153335;5131.9743401282985;5138.3577052868395;4947.257911313296;4962.602991760659;4968.478309777475;4977.113274300906;4986.207723674745;3713.9628603713954;3848.8845334639864;3869.361555343379;3896.1428485733095;3909.863154789583;3872.2120073547144;3898.493195884531;3904.949901301825;3907.785071821049;3925.4308125321813;3852.8266228019666;3886.1061955750192;3893.099640767618;3905.047476261869;3906.964654366581;3821.503204583414;3885.1258466844733;3889.961100388988;3925.411188321732;3935.60643935607;3417.1969587147;3421.298633780069;3426.194844211608;3431.588209414861;3437.8796742114155;4884.902301953976;4914.287428322909;4914.3611330527165;4914.655974081816;4951.257311403282;4368.934465983013;4491.932621010687;4498.595126438603;4511.165434394615;4518.209313370147;5245.895082098375;5248.8425347239645;5250.343707036621;5265.236540701577;5291.894162116774;3746.9437958430644;3748.7188460865273;3753.2118255166447;3761.9059523511855;3768.078280077153;5351.892962140774;5551.309143773505;5559.99840057579;5563.833085007415;5582.86042848928;3813.4936700003345;3816.961830381716;3821.216650586623;3827;3828.2343531293855;3895.552011518655;3907.9804600976813;3912.1784425270444;3912.8239229234755;3919;4448.399466072104;4454.643628509776;4481.305397663367;4484.349769283501;4487.192305385062;5003.2745251938995;5256.1327380982475;5264.368275806851;5286.682799031993;5338.813141540105;1288.8131220973094;1309.6594885329691;1309.9017573682013;1310.5347601601295;1310.5347601601295;801.7394346837185;817.3787921179946;834.1325021977076;841.6591280531395;842.3682238321259;4469.865904022885;4510.391097201901;4633.328167415706;4637.976810115928;4657.6506761992305;5454.945450545523;5462.20797984298;5468.808591699351;5485.50630443262;5505.862353441196;4626.884327891829;4667.183242932541;4674.555917187861;4676.462206846189;4687.859364219079;2740.794440416937;2898.825975479934;2903.637045369329;2910.257884239548;2912.6504819421807;5150.665206761549;5173.3533308336455;5173.4826517347965;5175.353080864892;5186.507281808223;5271.947280527223;5532.197831314437;5548.750306236229;5582.497575218169;5603.831885043455;5100.515451032146;5118.769655365443;5126.5898728101665;5139.563137133386;5169.7673604687125;5482.616216864782;5494.670319780826;5518.889622207614;5518.972405138109;5521.779128834802;5195.506426889439;5384.919226211531;5401.002443643815;5412.75642596092;5413.756380962945;5122;5134.7175905324075;5177.559907407913;5197.974010129925;5208.713520756395;3804.410316400962;3824.4645749594524;3833.041739565109;3833.1758671885677;3836.7506112102624;5348.812791552277;5425.348958125051;5449.509544141047;5486.725663716878;5523.28197334344;5289.285946397187;5290.841274761763;5314.910443359025;5324.653897496805;5325.334333208349;5276.754795800632;5279.788808447619;5343.919841202307;5352.4915133062295;5363.168708850135;5022.949770502249;5200.869978250574;5216.817411390583;5221.660592061504;5227.686338819683;5129.948700512947;5174.430812610685;5297.735113244399;5347.946520534745;5385.838424847261;5206.55744261742;5212.218167274939;5212.227842533557;5235.60732945023;5262.473752624707 22:19:58 INFO - PROCESS | 22913 | |5;yui.html;622.8318354044408;628.5443053786008;628.9496840252777;679.3308591037827;744.4788647946438;12872.613821585355;13201.603951881434;14122.223277719735;14127.434902603909;14136.505222317208;13633.250171240577;13772;13879.167249965009;13889.236092014935;13910.93044534776;621.5804332075853;753.5968256982516;775.1047540091204;776.97669069928;778.5056489129415;748.8951546783454;777.6461709922;777.7355699062317;782.3271986091956;785.2932360875201;798.4490701416033;800.6957356204634;801.6913488307015;802.2018091998441;802.7792357101786;791.0507391130666;796.2753893956472;798.5089170160368;799.4084377560622;799.6241766369797;584.4097461563808;585.3824215452696;585.4993980146999;590.0618017352431;591.6716222496513;12704.6823829405;12766.170198937132;12777.361131943459;12778.936105319413;12902.612921612366;13364.599062028155;13563.134506665552;13873.861261387357;13965.162090274514;14088.788668169986;10678.51946662402;10790.5683772649;10953.83569246462;10992.17558683094;11137.888621113767;3350.9329813403597;3354.9161270968175;3373.8819141329936;3400.319936012783;3401.149712571857;63234.68382658057;65019.34980650227;66114.66942665256;66254.66872665654;67006.66496667534;9825.459599722084;10000.449975251431;10170.440625765506;10281.794364112677;10410.479476026168;19716.112774925165;19720.70418943717;19731.506712332306;19846.801531984784;19868.90065549663;6809.31906809325;6833.863322733518;6869.347411995853;6917;7190.9280907191305;3750.1937083527173;3807.9809600951817;3809.2000679856988;3826;3914.3541315683165;2838.2904273931517;2933.2080338308538;2947.7347038766616;2950.350922796981;2952.9114126576237;505.7825135191903;506.4252073896154;511.83109573840545;514.7992283009554;515.2374485761095;476.8419382980474;508.8117396563295;549.4944650921162;567.6764244380663;569.5728203847115;7265.963670181721;8106.229908158715;8212.46618969765;8537.786555336166;8857.955710221408;550.9256250406144;559.9804006859822;568.835037839022;572.86537663649;581.4040608376364;3812.980935095307;3822.6750726188584;3844.3464611016193;3950.308695978192;4006.3790112532606;100933;102896.48551757193;103108.48445757723;105155;106311.4684426573;88596.5570172145;89260;90288.09711902928;90686.54656726673;93314;72505.63747181125;81521.59239203767;82187.17812821796;82534;82914;7246.746363877239;7519.586422746583;7568;7598.544087354777;7787.610619469117;30284.697153028188;32150.678493215702;38134.61865381311;38164;38261.4260786094;38173;50841;54759;58494.707526462094;62609.68695156495;11252.943735281271;11558.248713833575;11568.942155289169;11751.883571060736;11958.282503049844;12389.442475088823;12628.558000469939;12941;12969;13392.665183370495;11992.880071199177;12163.939180304042;12199.14605977573;12425.813612795635;12449.439775209956;11010.834837477283;11746.353950532803;11887.643370698894;12022.579209727968;12084.75830483403;11782.764344713229;12035.097367697283;12287.324197168884;12601.810972835598;12837.871621283668;10079.143272821599;10244.436555989492;10392.168626510012;10447.425391603534;10513.89486105129;8385.874211886705;9565.473898935346;10393.688189354332;10510.527026283682;10544.630937917136 22:19:58 INFO - PROCESS | 22913 | __end_tp_report 22:19:58 INFO - PROCESS | 22913 | __start_cc_report 22:19:58 INFO - PROCESS | 22913 | _x_x_mozilla_cycle_collect,372 22:19:58 INFO - PROCESS | 22913 | __end_cc_report 22:19:58 INFO - PROCESS | 22913 | __startTimestamp1471065598958__endTimestamp 22:19:58 INFO - PROCESS | 22913 | 22:19:58 INFO - PROCESS | 22913 | ------- Summary: start ------- 22:19:58 INFO - PROCESS | 22913 | Number of tests: 6 22:19:58 INFO - PROCESS | 22913 | 22:19:58 INFO - PROCESS | 22913 | [#0] dojo.html Cycles:165 Average:4829.28 Median:4925.83 stddev:503.10 (10.2%) stddev-sans-first:475.90 22:19:58 INFO - PROCESS | 22913 | Values: 2692.8 2720.0 2727.8 2740.3 2746.3 4759.8 4842.2 4846.3 4896.8 4936.0 4873.0 4880.4 4968.0 5000.1 5035.2 4505.1 4539.2 4563.7 4581.7 4639.3 4578.8 4579.2 4579.9 4594.2 4599.5 4393.1 4432.0 4469.0 4470.0 4569.3 4374.7 4424.6 4430.2 4450.8 4548.3 4467.5 4484.8 4491.5 4500.1 4526.2 4816.2 4844.6 4851.7 4922.0 4925.8 5221.8 5243.2 5244.4 5290.3 5303.2 5272.3 5281.6 5299.6 5304.3 5321.0 4697.6 4817.5 4870.9 4871.1 4911.0 5366.0 5388.5 5401.6 5416.8 5435.2 5115.5 5161.7 5163.8 5189.0 5218.0 5027.9 5128.4 5166.0 5184.0 5246.2 5161.4 5171.8 5173.5 5174.1 5199.2 5159.1 5163.5 5165.5 5169.4 5215.1 4319.8 4384.9 4405.4 4425.9 4435.8 3868.2 3871.4 3874.6 3913.1 3923.8 4542.4 4547.7 4556.3 4557.2 4588.1 5086.2 5161.1 5189.9 5221.7 5297.7 4512.2 4537.0 4563.7 4577.1 4580.2 4728.4 4735.2 4738.4 4751.2 4778.9 4725.4 4817.8 4819.6 4905.2 4913.1 5227.8 5228.0 5236.4 5268.9 5283.9 4826.7 4839.6 4842.6 4857.7 4907.3 5024.0 5096.4 5110.1 5122.5 5164.4 5212.9 5242.7 5258.5 5260.0 5270.6 5097.6 5102.1 5110.6 5111.5 5162.1 4908.8 5023.9 5047.2 5086.4 5088.4 4946.7 4960.7 4990.5 5009.1 5027.5 5162.4 5176.3 5189.9 5192.5 5222.6 4884.8 4979.1 5001.2 5029.0 5056.0 22:19:58 INFO - PROCESS | 22913 | 22:19:58 INFO - PROCESS | 22913 | [#1] ext.html Cycles:180 Average:43568.65 Median:35123.65 stddev:81140.77 (231.0%) stddev-sans-first:81303.98 22:19:58 INFO - PROCESS | 22913 | Values: 507.8 520.1 521.7 525.3 550.1 34895.5 38653.8 38694.4 38730.6 38863.0 38365.8 38653.0 38700.2 38829.8 38840.6 7485.8 7509.5 7594.7 7604.6 7626.7 7604.5 7632.8 7650.1 7684.7 7734.4 7655.7 7672.9 7707.3 7724.5 7727.6 7646.5 7664.4 7665.8 7704.4 7707.1 7446.8 7469.3 7497.5 7514.1 7523.2 36184.0 36236.6 36294.3 36620.3 36620.5 2330.0 2955.5 3023.5 3059.5 3123.2 27171.9 27599.3 27705.9 27742.3 27780.6 3198.9 3244.7 3270.8 3349.3 3441.4 218124.0 218715.0 219355.0 220353.9 220417.0 27583.2 28326.4 30849.0 31022.7 31118.4 32462.4 32579.8 32659.0 32697.5 32724.2 11191.7 11230.2 11241.4 11267.8 11303.5 9678.2 9709.8 9721.1 9745.9 9778.8 7656.3 7668.5 7752.8 7798.7 7822.3 3042.5 3051.4 3079.4 3085.4 3132.4 856.6 878.9 971.9 989.7 999.3 26915.6 27459.5 27691.6 28251.7 28377.1 915.3 970.1 971.9 1014.1 1017.1 13974.4 14584.9 14608.6 14631.0 14710.7 384586.0 388567.0 389625.0 391685.0 392345.0 47737.8 47800.0 48182.5 48289.0 48303.0 1170.3 1201.1 1204.7 1210.3 1210.9 25351.2 26599.9 27451.6 27687.3 27934.0 41117.2 41593.0 41781.6 41904.6 41937.8 286739.0 288157.0 288615.0 289452.0 289540.3 24486.9 24807.3 24827.3 24849.9 24918.6 39798.8 39993.2 40317.4 40665.2 41454.2 34407.7 34810.8 34970.0 35460.6 36023.0 34799.8 34873.0 35100.8 35146.5 35417.8 34496.5 34847.8 35291.6 36496.5 36666.0 30207.0 32439.7 33797.0 33993.5 34048.0 25137.4 25146.0 25480.5 26046.0 26161.7 22:19:58 INFO - PROCESS | 22913 | 22:19:58 INFO - PROCESS | 22913 | [#2] jquery.html Cycles:180 Average:21857.87 Median:19201.00 stddev:51793.68 (269.7%) stddev-sans-first:51913.83 22:19:58 INFO - PROCESS | 22913 | Values: 363.0 368.5 372.7 383.6 391.6 15819.7 16254.8 17108.1 17121.6 17144.3 16358.8 16855.8 17167.5 17286.0 17365.2 4950.7 5222.5 5224.9 5225.9 5226.6 4988.6 5128.2 5132.8 5191.2 5198.9 5135.2 5138.5 5146.9 5151.1 5163.5 4959.4 5089.6 5110.1 5125.6 5157.3 4610.5 4619.1 4628.4 4633.9 4641.6 20311.8 20701.4 20997.5 21008.7 21066.2 2089.3 2119.6 2326.2 2337.3 2544.5 12640.6 13420.6 13605.2 13968.9 14147.2 1739.5 1793.8 1855.7 1860.8 1864.9 66522.0 66658.0 66709.0 67196.0 67982.0 9680.2 9701.6 9770.4 9899.8 10135.7 13412.9 13449.5 13457.3 13484.5 13523.0 6609.7 6626.6 6812.5 6837.6 6996.4 6035.8 6191.4 6302.8 6304.4 6331.3 6068.3 6115.8 6116.8 6247.7 6396.2 1782.3 1832.4 1845.5 1850.8 1856.6 846.3 883.8 891.7 940.7 1007.5 17310.0 18169.4 18500.7 18584.8 18696.0 855.2 885.8 892.5 906.0 922.7 10047.3 10217.3 10451.0 10523.4 10535.7 160987.0 163351.2 374780.0 374868.0 375776.0 78336.5 78699.0 81684.6 83120.6 84509.6 915.5 944.1 945.7 958.1 959.9 14946.4 15769.4 15913.9 16214.8 16708.7 37311.0 38018.4 39014.8 40002.6 41284.8 46276.8 48068.8 51108.6 51891.7 52238.2 7476.5 7621.4 7732.0 7900.0 8012.2 10439.4 12149.3 12390.0 12502.4 12807.7 10248.2 10384.2 10424.9 10451.0 10587.1 10519.7 10926.7 10983.7 10992.1 11205.1 10523.9 10687.4 10750.7 10784.5 10821.8 7614.7 7753.7 7754.8 7784.5 7925.7 9947.2 10551.7 10672.5 10866.7 11244.8 22:19:58 INFO - PROCESS | 22913 | 22:19:58 INFO - PROCESS | 22913 | [#3] mootools.html Cycles:180 Average:5110.70 Median:4865.77 stddev:2883.91 (59.3%) stddev-sans-first:2878.29 22:19:58 INFO - PROCESS | 22913 | Values: 1368.7 1382.2 1445.8 1647.2 1694.3 6714.0 7439.6 7499.4 8159.6 8166.8 7584.4 7888.9 7889.8 7925.6 7938.6 2163.2 2194.1 2197.0 2200.3 2207.0 2145.0 2193.6 2221.5 2229.2 2239.7 2193.3 2196.2 2198.8 2210.8 2229.6 2145.5 2155.7 2156.5 2158.1 2164.2 2099.7 2140.2 2156.7 2157.6 2159.5 7673.2 7807.9 7839.8 7844.5 7853.1 4470.6 4579.2 4605.6 4611.9 4643.2 2889.2 3029.3 3044.0 3051.0 3052.5 885.9 944.1 959.7 960.1 977.5 10795.5 10886.9 10960.9 10966.5 11003.3 4023.9 4166.9 4300.2 4313.9 4337.6 9110.5 9130.7 9135.0 9136.0 9147.1 4525.4 4557.0 4558.4 4566.5 4576.2 3692.6 3963.9 4057.2 4167.0 4168.5 3611.4 3658.5 3693.7 3710.9 3783.1 1249.6 1250.1 1255.5 1260.5 1262.8 796.0 812.7 821.6 823.3 824.1 4830.8 4927.9 4992.9 5218.7 5274.4 397.6 875.4 875.7 910.5 934.6 3533.3 3551.2 3625.0 3630.6 3638.8 9395.1 9750.6 9835.8 9878.9 9914.3 9745.5 9756.5 9769.2 9770.0 9779.1 7164.1 7198.9 7206.4 7216.4 7263.5 4761.5 4825.3 4834.7 4860.9 4870.7 8491.6 8663.3 8727.1 8761.8 8780.1 8709.7 8718.3 8835.2 8843.1 8909.1 5762.4 6244.3 6316.7 6411.2 6460.4 7688.3 7748.3 7750.7 7757.1 7777.6 6744.3 6813.7 6839.2 6841.4 7027.2 6362.1 6396.3 6464.2 6572.6 6976.8 6267.5 6341.8 6359.1 6364.3 6380.0 4257.6 4469.7 4551.1 4560.7 4567.8 4368.8 4386.6 4474.5 4521.4 4604.8 22:19:58 INFO - PROCESS | 22913 | 22:19:58 INFO - PROCESS | 22913 | [#4] prototype.html Cycles:180 Average:4384.59 Median:5005.45 stddev:1293.21 (25.8%) stddev-sans-first:1259.80 22:19:58 INFO - PROCESS | 22913 | Values: 290.4 294.8 301.2 301.9 302.4 5007.6 5113.8 5125.9 5132.0 5138.4 4947.3 4962.6 4968.5 4977.1 4986.2 3714.0 3848.9 3869.4 3896.1 3909.9 3872.2 3898.5 3904.9 3907.8 3925.4 3852.8 3886.1 3893.1 3905.0 3907.0 3821.5 3885.1 3890.0 3925.4 3935.6 3417.2 3421.3 3426.2 3431.6 3437.9 4884.9 4914.3 4914.4 4914.7 4951.3 4368.9 4491.9 4498.6 4511.2 4518.2 5245.9 5248.8 5250.3 5265.2 5291.9 3746.9 3748.7 3753.2 3761.9 3768.1 5351.9 5551.3 5560.0 5563.8 5582.9 3813.5 3817.0 3821.2 3827.0 3828.2 3895.6 3908.0 3912.2 3912.8 3919.0 4448.4 4454.6 4481.3 4484.3 4487.2 5003.3 5256.1 5264.4 5286.7 5338.8 1288.8 1309.7 1309.9 1310.5 1310.5 801.7 817.4 834.1 841.7 842.4 4469.9 4510.4 4633.3 4638.0 4657.7 5454.9 5462.2 5468.8 5485.5 5505.9 4626.9 4667.2 4674.6 4676.5 4687.9 2740.8 2898.8 2903.6 2910.3 2912.7 5150.7 5173.4 5173.5 5175.4 5186.5 5271.9 5532.2 5548.8 5582.5 5603.8 5100.5 5118.8 5126.6 5139.6 5169.8 5482.6 5494.7 5518.9 5519.0 5521.8 5195.5 5384.9 5401.0 5412.8 5413.8 5122.0 5134.7 5177.6 5198.0 5208.7 3804.4 3824.5 3833.0 3833.2 3836.8 5348.8 5425.3 5449.5 5486.7 5523.3 5289.3 5290.8 5314.9 5324.7 5325.3 5276.8 5279.8 5343.9 5352.5 5363.2 5022.9 5200.9 5216.8 5221.7 5227.7 5129.9 5174.4 5297.7 5347.9 5385.8 5206.6 5212.2 5212.2 5235.6 5262.5 22:19:58 INFO - PROCESS | 22913 | 22:19:58 INFO - PROCESS | 22913 | [#5] yui.html Cycles:180 Average:17969.04 Median:20997.84 stddev:26283.69 (125.2%) stddev-sans-first:26325.15 22:19:58 INFO - PROCESS | 22913 | Values: 622.8 628.5 628.9 679.3 744.5 12872.6 13201.6 14122.2 14127.4 14136.5 13633.3 13772.0 13879.2 13889.2 13910.9 621.6 753.6 775.1 777.0 778.5 748.9 777.6 777.7 782.3 785.3 798.4 800.7 801.7 802.2 802.8 791.1 796.3 798.5 799.4 799.6 584.4 585.4 585.5 590.1 591.7 12704.7 12766.2 12777.4 12778.9 12902.6 13364.6 13563.1 13873.9 13965.2 14088.8 10678.5 10790.6 10953.8 10992.2 11137.9 3350.9 3354.9 3373.9 3400.3 3401.1 63234.7 65019.3 66114.7 66254.7 67006.7 9825.5 10000.4 10170.4 10281.8 10410.5 19716.1 19720.7 19731.5 19846.8 19868.9 6809.3 6833.9 6869.3 6917.0 7190.9 3750.2 3808.0 3809.2 3826.0 3914.4 2838.3 2933.2 2947.7 2950.4 2952.9 505.8 506.4 511.8 514.8 515.2 476.8 508.8 549.5 567.7 569.6 7266.0 8106.2 8212.5 8537.8 8858.0 550.9 560.0 568.8 572.9 581.4 3813.0 3822.7 3844.3 3950.3 4006.4 100933.0 102896.5 103108.5 105155.0 106311.5 88596.6 89260.0 90288.1 90686.5 93314.0 72505.6 81521.6 82187.2 82534.0 82914.0 7246.7 7519.6 7568.0 7598.5 7787.6 30284.7 32150.7 38134.6 38164.0 38261.4 38173.0 50841.0 54759.0 58494.7 62609.7 11252.9 11558.2 11568.9 11751.9 11958.3 12389.4 12628.6 12941.0 12969.0 13392.7 11992.9 12163.9 12199.1 12425.8 12449.4 11010.8 11746.4 11887.6 12022.6 12084.8 11782.8 12035.1 12287.3 12601.8 12837.9 10079.1 10244.4 10392.2 10447.4 10513.9 8385.9 9565.5 10393.7 10510.5 10544.6 22:19:58 INFO - PROCESS | 22913 | -------- Summary: end -------- 22:19:58 INFO - PROCESS | 22913 | 22:19:59 INFO - TEST-INFO | 22913: exit 0 22:19:59 INFO - TEST-OK | dromaeo_css | took 1117655ms 22:19:59 INFO - TEST-START | kraken 22:19:59 INFO - operating with platform_type : linux_ 22:19:59 INFO - Initialising browser for kraken test... 22:19:59 INFO - TEST-INFO | started process 23276 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpizvTFf/profile http://localhost:48609/getInfo.html) 22:20:04 INFO - PROCESS | 23276 | __metrics Screen width/height:1600/1200 22:20:04 INFO - PROCESS | 23276 | colorDepth:24 22:20:04 INFO - PROCESS | 23276 | Browser inner width/height: 1024/697 22:20:04 INFO - PROCESS | 23276 | __metrics 22:20:04 ERROR - PROCESS | 23276 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 22:20:05 INFO - TEST-INFO | 23276: exit 0 22:20:05 INFO - Browser initialized. 22:20:05 INFO - Running cycle 1/1 for kraken test... 22:20:05 INFO - TEST-INFO | started process 23397 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpizvTFf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:20:17 INFO - PROCESS | 23397 | RSS: Main: 163766272 22:20:17 INFO - PROCESS | 23397 | 22:20:20 INFO - PROCESS | 23397 | Cycle 1(1): loaded http://localhost:48609/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48609/tests/kraken/driver.html?testName=audio-beat-detection) 22:20:21 INFO - PROCESS | 23397 | RSS: Main: 168919040 22:20:21 INFO - PROCESS | 23397 | 22:20:24 INFO - PROCESS | 23397 | Cycle 1(1): loaded http://localhost:48609/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48609/tests/kraken/driver.html?testName=audio-dft) 22:20:24 INFO - PROCESS | 23397 | RSS: Main: 167796736 22:20:24 INFO - PROCESS | 23397 | 22:20:27 INFO - PROCESS | 23397 | Cycle 1(1): loaded http://localhost:48609/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48609/tests/kraken/driver.html?testName=audio-fft) 22:20:28 INFO - PROCESS | 23397 | RSS: Main: 164061184 22:20:28 INFO - PROCESS | 23397 | 22:20:30 INFO - PROCESS | 23397 | Cycle 1(1): loaded http://localhost:48609/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48609/tests/kraken/driver.html?testName=audio-oscillator) 22:20:31 INFO - PROCESS | 23397 | RSS: Main: 164880384 22:20:31 INFO - PROCESS | 23397 | 22:20:33 INFO - PROCESS | 23397 | Cycle 1(1): loaded http://localhost:48609/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48609/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:20:34 INFO - PROCESS | 23397 | RSS: Main: 165613568 22:20:34 INFO - PROCESS | 23397 | 22:20:37 INFO - PROCESS | 23397 | Cycle 1(1): loaded http://localhost:48609/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48609/tests/kraken/driver.html?testName=imaging-darkroom) 22:20:38 INFO - PROCESS | 23397 | RSS: Main: 165924864 22:20:38 INFO - PROCESS | 23397 | 22:20:41 INFO - PROCESS | 23397 | Cycle 1(1): loaded http://localhost:48609/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48609/tests/kraken/driver.html?testName=imaging-desaturate) 22:20:42 INFO - PROCESS | 23397 | RSS: Main: 162476032 22:20:42 INFO - PROCESS | 23397 | 22:20:45 INFO - PROCESS | 23397 | Cycle 1(1): loaded http://localhost:48609/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48609/tests/kraken/driver.html?testName=json-parse-financial) 22:20:45 INFO - PROCESS | 23397 | RSS: Main: 164724736 22:20:45 INFO - PROCESS | 23397 | 22:20:47 INFO - PROCESS | 23397 | Cycle 1(1): loaded http://localhost:48609/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48609/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:20:48 INFO - PROCESS | 23397 | RSS: Main: 164732928 22:20:48 INFO - PROCESS | 23397 | 22:20:50 INFO - PROCESS | 23397 | Cycle 1(1): loaded http://localhost:48609/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48609/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:20:50 INFO - PROCESS | 23397 | RSS: Main: 164810752 22:20:50 INFO - PROCESS | 23397 | 22:20:53 INFO - PROCESS | 23397 | Cycle 1(1): loaded http://localhost:48609/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48609/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:20:53 INFO - PROCESS | 23397 | RSS: Main: 166141952 22:20:53 INFO - PROCESS | 23397 | 22:20:56 INFO - PROCESS | 23397 | Cycle 1(1): loaded http://localhost:48609/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48609/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:20:57 INFO - PROCESS | 23397 | RSS: Main: 166252544 22:20:57 INFO - PROCESS | 23397 | 22:21:00 INFO - PROCESS | 23397 | Cycle 1(1): loaded http://localhost:48609/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48609/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:21:00 INFO - PROCESS | 23397 | RSS: Main: 166141952 22:21:00 INFO - PROCESS | 23397 | 22:21:02 INFO - PROCESS | 23397 | Cycle 1(1): loaded http://localhost:48609/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48609/tests/kraken/driver.html?testName=ai-astar) 22:21:03 INFO - PROCESS | 23397 | RSS: Main: 166576128 22:21:03 INFO - PROCESS | 23397 | 22:21:03 INFO - PROCESS | 23397 | __start_tp_report 22:21:03 INFO - PROCESS | 23397 | _x_x_mozilla_page_load 22:21:03 INFO - PROCESS | 23397 | _x_x_mozilla_page_load_details 22:21:03 INFO - PROCESS | 23397 | |i|pagename|runs| 22:21:03 INFO - PROCESS | 23397 | |0;ai-astar;107;115;116;118;120;117;122;115;116;117 22:21:03 INFO - PROCESS | 23397 | |1;audio-beat-detection;154;123;143;189;131;152;158;130;195;123 22:21:03 INFO - PROCESS | 23397 | |2;audio-dft;163;166;171;164;163;163;162;165;164;164 22:21:03 INFO - PROCESS | 23397 | |3;audio-fft;78;77;76;173;76;77;78;77;174;77 22:21:03 INFO - PROCESS | 23397 | |4;audio-oscillator;87;87;156;86;87;85;142;87;86;149 22:21:03 INFO - PROCESS | 23397 | |5;imaging-gaussian-blur;117;118;117;119;117;118;118;118;122;118 22:21:03 INFO - PROCESS | 23397 | |6;imaging-darkroom;148;148;149;147;148;148;150;147;148;147 22:21:03 INFO - PROCESS | 23397 | |7;imaging-desaturate;95;96;98;95;96;96;96;98;96;96 22:21:03 INFO - PROCESS | 23397 | |8;json-parse-financial;62;65;70;65;66;73;65;65;64;71 22:21:03 INFO - PROCESS | 23397 | |9;json-stringify-tinderbox;66;66;66;65;65;65;65;69;67;66 22:21:03 INFO - PROCESS | 23397 | |10;stanford-crypto-aes;92;91;86;84;83;89;89;86;84;87 22:21:03 INFO - PROCESS | 23397 | |11;stanford-crypto-ccm;149;139;136;149;155;143;138;144;158;134 22:21:03 INFO - PROCESS | 23397 | |12;stanford-crypto-pbkdf2;177;178;176;177;177;175;179;174;174;175 22:21:03 INFO - PROCESS | 23397 | |13;stanford-crypto-sha256-iterative;71;69;70;69;70;69;68;71;68;72 22:21:03 INFO - PROCESS | 23397 | __end_tp_report 22:21:03 INFO - PROCESS | 23397 | __start_cc_report 22:21:03 INFO - PROCESS | 23397 | _x_x_mozilla_cycle_collect,966 22:21:03 INFO - PROCESS | 23397 | __end_cc_report 22:21:03 INFO - PROCESS | 23397 | __startTimestamp1471065663018__endTimestamp 22:21:03 INFO - PROCESS | 23397 | 22:21:03 INFO - PROCESS | 23397 | ------- Summary: start ------- 22:21:03 INFO - PROCESS | 23397 | Number of tests: 14 22:21:03 INFO - PROCESS | 23397 | 22:21:03 INFO - PROCESS | 23397 | [#0] ai-astar Cycles:10 Average:116.30 Median:117.00 stddev:3.95 (3.4%) stddev-sans-first:2.35 22:21:03 INFO - PROCESS | 23397 | Values: 107.0 115.0 116.0 118.0 120.0 117.0 122.0 115.0 116.0 117.0 22:21:03 INFO - PROCESS | 23397 | 22:21:03 INFO - PROCESS | 23397 | [#1] audio-beat-detection Cycles:10 Average:149.80 Median:153.00 stddev:25.60 (16.7%) stddev-sans-first:27.11 22:21:03 INFO - PROCESS | 23397 | Values: 154.0 123.0 143.0 189.0 131.0 152.0 158.0 130.0 195.0 123.0 22:21:03 INFO - PROCESS | 23397 | 22:21:03 INFO - PROCESS | 23397 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:2.55 (1.6%) stddev-sans-first:2.65 22:21:03 INFO - PROCESS | 23397 | Values: 163.0 166.0 171.0 164.0 163.0 163.0 162.0 165.0 164.0 164.0 22:21:03 INFO - PROCESS | 23397 | 22:21:03 INFO - PROCESS | 23397 | [#3] audio-fft Cycles:10 Average:96.30 Median:77.00 stddev:40.69 (52.8%) stddev-sans-first:42.62 22:21:03 INFO - PROCESS | 23397 | Values: 78.0 77.0 76.0 173.0 76.0 77.0 78.0 77.0 174.0 77.0 22:21:03 INFO - PROCESS | 23397 | 22:21:03 INFO - PROCESS | 23397 | [#4] audio-oscillator Cycles:10 Average:105.20 Median:86.50 stddev:30.41 (35.2%) stddev-sans-first:31.53 22:21:03 INFO - PROCESS | 23397 | Values: 87.0 87.0 156.0 86.0 87.0 85.0 142.0 87.0 86.0 149.0 22:21:03 INFO - PROCESS | 23397 | 22:21:03 INFO - PROCESS | 23397 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:1.48 (1.3%) stddev-sans-first:1.50 22:21:03 INFO - PROCESS | 23397 | Values: 117.0 118.0 117.0 119.0 117.0 118.0 118.0 118.0 122.0 118.0 22:21:03 INFO - PROCESS | 23397 | 22:21:03 INFO - PROCESS | 23397 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.94 (0.6%) stddev-sans-first:1.00 22:21:03 INFO - PROCESS | 23397 | Values: 148.0 148.0 149.0 147.0 148.0 148.0 150.0 147.0 148.0 147.0 22:21:03 INFO - PROCESS | 23397 | 22:21:03 INFO - PROCESS | 23397 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.03 (1.1%) stddev-sans-first:1.00 22:21:03 INFO - PROCESS | 23397 | Values: 95.0 96.0 98.0 95.0 96.0 96.0 96.0 98.0 96.0 96.0 22:21:03 INFO - PROCESS | 23397 | 22:21:03 INFO - PROCESS | 23397 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:65.50 stddev:3.50 (5.3%) stddev-sans-first:3.30 22:21:03 INFO - PROCESS | 23397 | Values: 62.0 65.0 70.0 65.0 66.0 73.0 65.0 65.0 64.0 71.0 22:21:03 INFO - PROCESS | 23397 | 22:21:03 INFO - PROCESS | 23397 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:1.25 (1.9%) stddev-sans-first:1.32 22:21:03 INFO - PROCESS | 23397 | Values: 66.0 66.0 66.0 65.0 65.0 65.0 65.0 69.0 67.0 66.0 22:21:03 INFO - PROCESS | 23397 | 22:21:03 INFO - PROCESS | 23397 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:88.00 stddev:3.07 (3.5%) stddev-sans-first:2.70 22:21:03 INFO - PROCESS | 23397 | Values: 92.0 91.0 86.0 84.0 83.0 89.0 89.0 86.0 84.0 87.0 22:21:03 INFO - PROCESS | 23397 | 22:21:03 INFO - PROCESS | 23397 | [#11] stanford-crypto-ccm Cycles:10 Average:144.50 Median:146.50 stddev:8.10 (5.5%) stddev-sans-first:8.43 22:21:03 INFO - PROCESS | 23397 | Values: 149.0 139.0 136.0 149.0 155.0 143.0 138.0 144.0 158.0 134.0 22:21:03 INFO - PROCESS | 23397 | 22:21:03 INFO - PROCESS | 23397 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.20 Median:177.00 stddev:1.69 (1.0%) stddev-sans-first:1.76 22:21:03 INFO - PROCESS | 23397 | Values: 177.0 178.0 176.0 177.0 177.0 175.0 179.0 174.0 174.0 175.0 22:21:03 INFO - PROCESS | 23397 | 22:21:03 INFO - PROCESS | 23397 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.34 (1.9%) stddev-sans-first:1.33 22:21:03 INFO - PROCESS | 23397 | Values: 71.0 69.0 70.0 69.0 70.0 69.0 68.0 71.0 68.0 72.0 22:21:03 INFO - PROCESS | 23397 | -------- Summary: end -------- 22:21:03 INFO - PROCESS | 23397 | 22:21:04 INFO - TEST-INFO | 23397: exit 0 22:21:04 INFO - TEST-OK | kraken | took 64367ms 22:21:04 INFO - SUITE-END | took 1182s 22:21:04 INFO - Completed test suite (00:19:42) 22:21:04 INFO - javascript benchmark 22:21:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6379.922996666689, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2692.8115031947764, 2720.034387792334, 2727.7681397081246, 2740.3423178437183, 2746.340878189234, 4759.833405830796, 4842.201036828923, 4846.345743324655, 4896.8041278348865, 4936.0, 4873.0, 4880.365552478182, 4967.975160124194, 5000.0999820032375, 5035.169197082477, 4505.144022635697, 4539.160255352754, 4563.726176429408, 4581.67928245023, 4639.304104384352, 4578.839740609079, 4579.175748365293, 4579.885502862422, 4594.173048851206, 4599.4710608279975, 4393.143337049277, 4432.0, 4469.039156581318, 4469.9776501117285, 4569.268916973285, 4374.737515749065, 4424.60178583929, 4430.224710675619, 4450.777461126931, 4548.295014272793, 4467.530909254514, 4484.8206071757095, 4491.483479399878, 4500.054988452429, 4526.207913615104, 4816.205326121186, 4844.563989240985, 4851.684640498356, 4922.0, 4925.827596034122, 5221.817236396708, 5243.239730239132, 5244.39689435716, 5290.285811415487, 5303.231031500411, 5272.3200702311005, 5281.551068159172, 5299.629025968184, 5304.2839216706025, 5321.042212401805, 4697.600703940135, 4817.470078291385, 4870.878228044327, 4871.050145221719, 4910.975445122787, 5366.0, 5388.461153884658, 5401.5948803839865, 5416.83749487516, 5435.184722291688, 5115.514026167508, 5161.74191290434, 5163.7676304566385, 5188.9740551297, 5218.0, 5027.899442011139, 5128.435872054071, 5166.044281807877, 5184.040952423814, 5246.186841039568, 5161.354830646169, 5171.81898633546, 5173.482651734872, 5174.094533456705, 5199.168133098686, 5159.071367153873, 5163.483651634807, 5165.509276618715, 5169.379674439091, 5215.087359712035, 4319.8488052918, 4384.934225986613, 4405.427294451701, 4425.933610995838, 4435.778211089432, 3868.2263547290654, 3871.3612253977776, 3874.612538746103, 3913.099987002948, 3923.843046278174, 4542.432195975503, 4547.704399214107, 4556.270996640522, 4557.1797076526545, 4588.105319462739, 5086.16078347076, 5161.148410512298, 5189.948100518946, 5221.7128057956415, 5297.682139071668, 4512.210363186429, 4537.02453972391, 4563.748993805372, 4577.0845830833305, 4580.152671755736, 4728.361671174416, 4735.2186889163595, 4738.3840100787365, 4751.168545504523, 4778.928316075262, 4725.36207611968, 4817.807287708452, 4819.614430845454, 4905.166121759238, 4913.066517361762, 5227.790888364423, 5227.973860130675, 5236.423993360803, 5268.947310526845, 5283.920741188808, 4826.686265392878, 4839.612830973584, 4842.58837998774, 4857.708537487762, 4907.33750943618, 5023.974880125576, 5096.420109765836, 5110.054639891632, 5122.462141475092, 5164.3802743671, 5212.869678258074, 5242.737863106906, 5258.526732594085, 5260.0, 5270.60470464709, 5097.617678674188, 5102.107131251942, 5110.616703747308, 5111.539961403491, 5162.09663308927, 4908.779104940358, 5023.924641130459, 5047.2429135629945, 5086.440491545853, 5088.414832294334, 4946.678465899705, 4960.677555958851, 4990.50094990498, 5009.148444764326, 5027.5475207230065, 5162.380514338303, 5176.301199338041, 5189.948100518946, 5192.532672059533, 5222.634415590872, 4884.780184891617, 4979.0788704089855, 5001.199808030698, 5029.0, 5056.0], "value": 4797.242601288514, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [507.79688124750106, 520.146958987261, 521.7339157029916, 525.3249574297029, 550.0676353580683, 34895.476567851474, 38653.80673096631, 38694.41958370623, 38730.61269387305, 38863.0, 38365.820614217075, 38653.0, 38700.225995480076, 38829.80585097078, 38840.61159388405, 7485.812854678622, 7509.511881727698, 7594.696212151507, 7604.619769011555, 7626.656800443966, 7604.543727376347, 7632.771016869475, 7650.120236172828, 7684.65419056141, 7734.419918506106, 7655.655495502688, 7672.884906726404, 7707.30634242918, 7724.459287849852, 7727.574983375912, 7646.502977306485, 7664.425168112414, 7665.770026899202, 7704.383649308098, 7707.075150981862, 7446.776596702053, 7469.253074692541, 7497.5126616770285, 7514.135874374462, 7523.172451030437, 36184.0, 36236.63763362359, 36294.27411451756, 36620.26759464823, 36620.450693239625, 2329.988350058256, 2955.5123404638207, 3023.486007378729, 3059.464593696094, 3123.2191952012, 27171.86414067937, 27599.31001724953, 27705.86147069272, 27742.3064423389, 27780.58329125065, 3198.9040328790174, 3244.691754283363, 3270.787398819093, 3349.3133907548895, 3441.380551500729, 218124.0, 218715.0, 219355.0, 220353.89823050943, 220417.0, 27583.172504824888, 28326.43347133087, 30849.0, 31022.689773102433, 31118.377632447224, 32462.350752984807, 32579.837100814344, 32659.0, 32697.50953735696, 32724.18189545233, 11191.72020699489, 11230.157738169506, 11241.381724005258, 11267.830982535268, 11303.491342889589, 9678.17735492477, 9709.757256068655, 9721.076497732704, 9745.902540974641, 9778.804423911482, 7656.310932016146, 7668.501547399401, 7752.806179845549, 7798.727044553527, 7822.335101516321, 3042.543618457205, 3051.404976029653, 3079.384123175374, 3085.4291955988215, 3132.420502207099, 856.5631527920681, 878.9384743068051, 971.9416834989923, 989.6585677941099, 999.3404353127047, 26915.596266056025, 27459.450810983668, 27691.584626230622, 28251.717482824908, 28377.148685539465, 915.3180880244128, 970.1075010989906, 971.8629203831534, 1014.1177175857051, 1017.0693815159046, 13974.441022358991, 14584.854151458561, 14608.561743147722, 14631.0, 14710.705785884222, 384586.0, 388567.0, 389625.0, 391685.0, 392345.0, 47737.76131119322, 47800.0, 48182.518174818506, 48289.0, 48303.0, 1170.309517384747, 1201.069171392178, 1204.740980689156, 1210.3040751567883, 1210.9212901161397, 25351.239462816146, 26599.86700066487, 27451.588226176224, 27687.30781730473, 27934.02230921908, 41117.1776564461, 41593.0, 41781.58218417777, 41904.58095419007, 41937.79031104947, 286739.0, 288157.0, 288615.0, 289452.0, 289540.2551693726, 24486.87756561206, 24807.25578232656, 24827.255182344557, 24849.875750621854, 24918.626220606344, 39798.801005994785, 39993.2001359977, 40317.39523907085, 40665.186696265315, 41454.1709165821, 34407.65592344045, 34810.82594587011, 34970.0, 35460.64539354573, 36023.0, 34799.826000869834, 34873.0, 35100.82449587736, 35146.47280290747, 35417.82291088528, 34496.48255276123, 34847.825760872045, 35291.647083528835, 36496.45255321226, 36666.0, 30207.0, 32439.675603243664, 33797.0, 33993.490097649046, 34048.0, 25137.371565711004, 25146.0, 25480.490390192463, 26046.0, 26161.73838261593], "value": 15671.212108358144, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.9600743918167, 368.52276302188665, 372.67018688460706, 383.5662720041337, 391.6044794757296, 15819.683606327866, 16254.75617865733, 17108.144592770357, 17121.57196070099, 17144.31422743089, 16358.83641163588, 16855.831441685612, 17167.484975450727, 17286.0, 17365.218565164567, 4950.727709975949, 5222.5038621331105, 5224.947750522503, 5225.947740522584, 5226.5818734501145, 4988.575971042447, 5128.205128205134, 5132.8460146195675, 5191.169412893938, 5198.948010519903, 5135.2297155426795, 5138.537531622153, 5146.897062058757, 5151.124308867483, 5163.509466600685, 4959.429665588467, 5089.567386772129, 5110.131277682803, 5125.564327032188, 5157.329547158883, 4610.5389461053965, 4619.12236675034, 4628.375169352128, 4633.86098417048, 4641.628669706415, 20311.79688203114, 20701.378958631267, 20997.475063123544, 21008.684869726967, 21066.157353705832, 2089.2583132987725, 2119.618468675638, 2326.220716060122, 2337.3104934044327, 2544.4783819316995, 12640.55758048473, 13420.597382078455, 13605.183688978694, 13968.930155349159, 14147.221902795342, 1739.5303268117664, 1793.8116497767808, 1855.6845336292727, 1860.8046155153784, 1864.85039557432, 66522.0, 66658.0, 66709.0, 67196.0, 67982.0, 9680.225581953428, 9701.563429645541, 9770.36200225935, 9899.752506187258, 10135.7466063349, 13412.865871341162, 13449.529266475627, 13457.327133643279, 13484.460621575026, 13523.0, 6609.735610575619, 6626.56927299724, 6812.489063320171, 6837.62393068386, 6996.440284777307, 6035.758569657252, 6191.380861913863, 6302.810915672446, 6304.369563043659, 6331.271903731038, 6068.302145253352, 6115.785947491817, 6116.816495505142, 6247.718852651642, 6396.168498095218, 1782.349442453521, 1832.395309547846, 1845.5201647571728, 1850.8334249917302, 1856.5915498590289, 846.3398549131687, 883.823235352932, 891.6567121658209, 940.7177846645978, 1007.496251874063, 17310.0, 18169.36407225741, 18500.722489162672, 18584.81415185858, 18696.0, 855.2114134384735, 885.7874110213502, 892.5492626223715, 906.0, 922.6932668329177, 10047.296689231829, 10217.33587316822, 10451.0, 10523.368597884151, 10535.683929482127, 160987.0, 163351.18324408302, 374780.0, 374868.0, 375776.0, 78336.51644384953, 78699.0, 81684.59157704173, 83120.58439707763, 84509.57745211235, 915.5330781301584, 944.1031020530523, 945.7304668169538, 958.1472489484364, 959.9376040557341, 14946.402143914122, 15769.44806931752, 15913.920430398237, 16214.837851621332, 16708.749368759236, 37311.0, 38018.42972355472, 39014.804925975186, 40002.59997399989, 41284.79357603193, 46276.7686161567, 48068.759656201495, 51108.56708643181, 51891.740541297055, 52238.21642675439, 7476.514026588255, 7621.35218506411, 7731.9613401934885, 7900.0, 8012.158723334199, 10439.425831579032, 12149.331786751813, 12390.0, 12502.374691290073, 12807.743845123232, 10248.231382646181, 10384.221183411426, 10424.85326614087, 10451.007154320327, 10587.100096491577, 10519.737006574896, 10926.72683182895, 10983.725406864893, 10992.120630349713, 11205.103591712807, 10523.894761052597, 10687.412192329186, 10750.73123171927, 10784.514696838818, 10821.835632873299, 7614.657340419805, 7753.689852405841, 7754.7673569793, 7784.455088144002, 7925.722599708983, 9947.204223662235, 10551.683449496528, 10672.466376680979, 10866.728331791768, 11244.775104498029], "value": 8381.122990541258, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.664677154097, 1382.191418020458, 1445.8120444342235, 1647.1928754910098, 1694.313802909822, 6713.966430167842, 7439.59082250476, 7499.362554182894, 8159.632816523256, 8166.836663266731, 7584.393248540117, 7888.934993775839, 7889.842203155948, 7925.603719814015, 7938.603069846514, 2163.2212403534713, 2194.1333173396497, 2196.967045494319, 2200.273909609825, 2206.9779302206935, 2144.957100857982, 2193.56128774245, 2221.5112675211426, 2229.208630936019, 2239.664050392446, 2193.3419974007816, 2196.1983875885267, 2198.835087368454, 2210.834187435949, 2229.6209644360415, 2145.4850835799375, 2155.655095184763, 2156.493224092337, 2158.125958986613, 2164.210063326874, 2099.7060411542398, 2140.2188201306567, 2156.687280344341, 2157.5792720419527, 2159.4601349662585, 7673.155952845183, 7807.882881756778, 7839.843203135905, 7844.450888437812, 7853.136155022943, 4470.552944705536, 4579.244424669925, 4605.5854973052255, 4611.930821037688, 4643.16423043852, 2889.2343528964843, 3029.3032602501326, 3044.0, 3051.0, 3052.465818481779, 885.9335549833788, 944.0512285153445, 959.6545243712258, 960.1358777100595, 977.4819345746765, 10795.514201860935, 10886.945565272123, 10960.890391096067, 10966.506507207196, 11003.33979961197, 4023.91952160961, 4166.91666166681, 4300.16146851361, 4313.870583882489, 4337.566243375637, 9110.498922559324, 9130.680426185185, 9135.0, 9136.040715724754, 9147.131022552847, 4525.434320709911, 4556.977215113903, 4558.407407037131, 4566.4748553916725, 4576.153411618795, 3692.630736926286, 3963.9009024774036, 4057.16828050249, 4167.0, 4168.499780026416, 3611.422172452395, 3658.451232315174, 3693.7229707772026, 3710.870119545803, 3783.1109689223013, 1249.6188662458037, 1250.1061740855332, 1255.4852510470664, 1260.4580030586935, 1262.8042653388738, 795.9840803183904, 812.6668066092874, 821.6220538552333, 823.3331001888489, 824.1058451579983, 4830.782614782343, 4927.90144197114, 4992.850214493571, 5218.6868787872845, 5274.393444753826, 397.6321902240416, 875.4222213339166, 875.746033650247, 910.4869470451359, 934.5934518484481, 3533.293341331744, 3551.1654761131113, 3624.9818750906074, 3630.567519761766, 3638.8180590970874, 9395.107464790834, 9750.561224744763, 9835.803283934281, 9878.851817222747, 9914.256430767722, 9745.512724363753, 9756.463394513228, 9769.218462522982, 9770.0, 9779.119879210763, 7164.104486939133, 7198.89201661965, 7206.387457066208, 7216.35052845236, 7263.527870688388, 4761.476237613929, 4825.324454576292, 4834.709917404967, 4860.878478038077, 4870.659053866196, 8491.617877195418, 8663.306935445024, 8727.127287271222, 8761.780955476164, 8780.121987801169, 8709.695160669346, 8718.302535797247, 8835.160659737314, 8843.115688431106, 8909.064548222343, 5762.366139724543, 6244.250689917239, 6316.715747791269, 6411.166548348685, 6460.3862633049785, 7688.308052275322, 7748.302652761278, 7750.728724494616, 7757.069151701832, 7777.57223352721, 6744.258131605618, 6813.693383797642, 6839.213490448463, 6841.418479429105, 7027.15674119109, 6362.109304697438, 6396.264429590657, 6464.159659244457, 6572.572782769296, 6976.7558135465015, 6267.4986001120715, 6341.8097457076365, 6359.109724638647, 6364.331745166691, 6380.0, 4257.5529569396, 4469.687121901436, 4551.089782043538, 4560.6807523473035, 4567.840125595588, 4368.825246990212, 4386.561343865588, 4474.507804141476, 4521.434820647419, 4604.815807367668], "value": 4117.316261395964, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.4061194856518, 294.81721332773685, 301.1747810997865, 301.874721990374, 302.3710681781894, 5007.624428167888, 5113.821016264432, 5125.923111153335, 5131.9743401282985, 5138.3577052868395, 4947.257911313296, 4962.602991760659, 4968.478309777475, 4977.113274300906, 4986.207723674745, 3713.9628603713954, 3848.8845334639864, 3869.361555343379, 3896.1428485733095, 3909.863154789583, 3872.2120073547144, 3898.493195884531, 3904.949901301825, 3907.785071821049, 3925.4308125321813, 3852.8266228019666, 3886.1061955750192, 3893.099640767618, 3905.047476261869, 3906.964654366581, 3821.503204583414, 3885.1258466844733, 3889.961100388988, 3925.411188321732, 3935.60643935607, 3417.1969587147, 3421.298633780069, 3426.194844211608, 3431.588209414861, 3437.8796742114155, 4884.902301953976, 4914.287428322909, 4914.3611330527165, 4914.655974081816, 4951.257311403282, 4368.934465983013, 4491.932621010687, 4498.595126438603, 4511.165434394615, 4518.209313370147, 5245.895082098375, 5248.8425347239645, 5250.343707036621, 5265.236540701577, 5291.894162116774, 3746.9437958430644, 3748.7188460865273, 3753.2118255166447, 3761.9059523511855, 3768.078280077153, 5351.892962140774, 5551.309143773505, 5559.99840057579, 5563.833085007415, 5582.86042848928, 3813.4936700003345, 3816.961830381716, 3821.216650586623, 3827.0, 3828.2343531293855, 3895.552011518655, 3907.9804600976813, 3912.1784425270444, 3912.8239229234755, 3919.0, 4448.399466072104, 4454.643628509776, 4481.305397663367, 4484.349769283501, 4487.192305385062, 5003.2745251938995, 5256.1327380982475, 5264.368275806851, 5286.682799031993, 5338.813141540105, 1288.8131220973094, 1309.6594885329691, 1309.9017573682013, 1310.5347601601295, 1310.5347601601295, 801.7394346837185, 817.3787921179946, 834.1325021977076, 841.6591280531395, 842.3682238321259, 4469.865904022885, 4510.391097201901, 4633.328167415706, 4637.976810115928, 4657.6506761992305, 5454.945450545523, 5462.20797984298, 5468.808591699351, 5485.50630443262, 5505.862353441196, 4626.884327891829, 4667.183242932541, 4674.555917187861, 4676.462206846189, 4687.859364219079, 2740.794440416937, 2898.825975479934, 2903.637045369329, 2910.257884239548, 2912.6504819421807, 5150.665206761549, 5173.3533308336455, 5173.4826517347965, 5175.353080864892, 5186.507281808223, 5271.947280527223, 5532.197831314437, 5548.750306236229, 5582.497575218169, 5603.831885043455, 5100.515451032146, 5118.769655365443, 5126.5898728101665, 5139.563137133386, 5169.7673604687125, 5482.616216864782, 5494.670319780826, 5518.889622207614, 5518.972405138109, 5521.779128834802, 5195.506426889439, 5384.919226211531, 5401.002443643815, 5412.75642596092, 5413.756380962945, 5122.0, 5134.7175905324075, 5177.559907407913, 5197.974010129925, 5208.713520756395, 3804.410316400962, 3824.4645749594524, 3833.041739565109, 3833.1758671885677, 3836.7506112102624, 5348.812791552277, 5425.348958125051, 5449.509544141047, 5486.725663716878, 5523.28197334344, 5289.285946397187, 5290.841274761763, 5314.910443359025, 5324.653897496805, 5325.334333208349, 5276.754795800632, 5279.788808447619, 5343.919841202307, 5352.4915133062295, 5363.168708850135, 5022.949770502249, 5200.869978250574, 5216.817411390583, 5221.660592061504, 5227.686338819683, 5129.948700512947, 5174.430812610685, 5297.735113244399, 5347.946520534745, 5385.838424847261, 5206.55744261742, 5212.218167274939, 5212.227842533557, 5235.60732945023, 5262.473752624707], "value": 3962.7554491553933, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [622.8318354044408, 628.5443053786008, 628.9496840252777, 679.3308591037827, 744.4788647946438, 12872.613821585355, 13201.603951881434, 14122.223277719735, 14127.434902603909, 14136.505222317208, 13633.250171240577, 13772.0, 13879.167249965009, 13889.236092014935, 13910.93044534776, 621.5804332075853, 753.5968256982516, 775.1047540091204, 776.97669069928, 778.5056489129415, 748.8951546783454, 777.6461709922, 777.7355699062317, 782.3271986091956, 785.2932360875201, 798.4490701416033, 800.6957356204634, 801.6913488307015, 802.2018091998441, 802.7792357101786, 791.0507391130666, 796.2753893956472, 798.5089170160368, 799.4084377560622, 799.6241766369797, 584.4097461563808, 585.3824215452696, 585.4993980146999, 590.0618017352431, 591.6716222496513, 12704.6823829405, 12766.170198937132, 12777.361131943459, 12778.936105319413, 12902.612921612366, 13364.599062028155, 13563.134506665552, 13873.861261387357, 13965.162090274514, 14088.788668169986, 10678.51946662402, 10790.5683772649, 10953.83569246462, 10992.17558683094, 11137.888621113767, 3350.9329813403597, 3354.9161270968175, 3373.8819141329936, 3400.319936012783, 3401.149712571857, 63234.68382658057, 65019.34980650227, 66114.66942665256, 66254.66872665654, 67006.66496667534, 9825.459599722084, 10000.449975251431, 10170.440625765506, 10281.794364112677, 10410.479476026168, 19716.112774925165, 19720.70418943717, 19731.506712332306, 19846.801531984784, 19868.90065549663, 6809.31906809325, 6833.863322733518, 6869.347411995853, 6917.0, 7190.9280907191305, 3750.1937083527173, 3807.9809600951817, 3809.2000679856988, 3826.0, 3914.3541315683165, 2838.2904273931517, 2933.2080338308538, 2947.7347038766616, 2950.350922796981, 2952.9114126576237, 505.7825135191903, 506.4252073896154, 511.83109573840545, 514.7992283009554, 515.2374485761095, 476.8419382980474, 508.8117396563295, 549.4944650921162, 567.6764244380663, 569.5728203847115, 7265.963670181721, 8106.229908158715, 8212.46618969765, 8537.786555336166, 8857.955710221408, 550.9256250406144, 559.9804006859822, 568.835037839022, 572.86537663649, 581.4040608376364, 3812.980935095307, 3822.6750726188584, 3844.3464611016193, 3950.308695978192, 4006.3790112532606, 100933.0, 102896.48551757193, 103108.48445757723, 105155.0, 106311.4684426573, 88596.5570172145, 89260.0, 90288.09711902928, 90686.54656726673, 93314.0, 72505.63747181125, 81521.59239203767, 82187.17812821796, 82534.0, 82914.0, 7246.746363877239, 7519.586422746583, 7568.0, 7598.544087354777, 7787.610619469117, 30284.697153028188, 32150.678493215702, 38134.61865381311, 38164.0, 38261.4260786094, 38173.0, 50841.0, 54759.0, 58494.707526462094, 62609.68695156495, 11252.943735281271, 11558.248713833575, 11568.942155289169, 11751.883571060736, 11958.282503049844, 12389.442475088823, 12628.558000469939, 12941.0, 12969.0, 13392.665183370495, 11992.880071199177, 12163.939180304042, 12199.14605977573, 12425.813612795635, 12449.439775209956, 11010.834837477283, 11746.353950532803, 11887.643370698894, 12022.579209727968, 12084.75830483403, 11782.764344713229, 12035.097367697283, 12287.324197168884, 12601.810972835598, 12837.871621283668, 10079.143272821599, 10244.436555989492, 10392.168626510012, 10447.425391603534, 10513.89486105129, 8385.874211886705, 9565.473898935346, 10393.688189354332, 10510.527026283682, 10544.630937917136], "value": 6559.061991176363, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1604.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 116.0, 118.0, 120.0, 117.0, 122.0, 115.0, 116.0, 117.0], "value": 116.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 143.0, 189.0, 131.0, 152.0, 158.0, 130.0, 195.0, 123.0], "value": 149.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 171.0, 164.0, 163.0, 163.0, 162.0, 165.0, 164.0, 164.0], "value": 164.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 76.0, 173.0, 76.0, 77.0, 78.0, 77.0, 174.0, 77.0], "value": 96.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 156.0, 86.0, 87.0, 85.0, 142.0, 87.0, 86.0, 149.0], "value": 105.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 119.0, 117.0, 118.0, 118.0, 118.0, 122.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 149.0, 147.0, 148.0, 148.0, 150.0, 147.0, 148.0, 147.0], "value": 148.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 98.0, 95.0, 96.0, 96.0, 96.0, 98.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 70.0, 65.0, 66.0, 73.0, 65.0, 65.0, 64.0, 71.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 65.0, 65.0, 65.0, 65.0, 69.0, 67.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 86.0, 84.0, 83.0, 89.0, 89.0, 86.0, 84.0, 87.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 139.0, 136.0, 149.0, 155.0, 143.0, 138.0, 144.0, 158.0, 134.0], "value": 144.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 178.0, 176.0, 177.0, 177.0, 175.0, 179.0, 174.0, 174.0, 175.0], "value": 176.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 70.0, 69.0, 70.0, 69.0, 68.0, 71.0, 68.0, 72.0], "value": 69.7, "unit": "score"}]}]} 22:21:04 INFO - Return code: 0 22:21:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:21:04 ERROR - # TBPL SUCCESS # 22:21:04 INFO - Running post-action listener: _resource_record_post_action 22:21:04 INFO - [mozharness: 2016-08-13 05:21:04.326059Z] Finished run-tests step (success) 22:21:04 INFO - Running post-run listener: _resource_record_post_run 22:21:04 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 8192; Write bytes: 413069312; Read time: 200; Write time: 277172 22:21:04 INFO - TinderboxPrint: CPU usage
13.3% 22:21:04 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 200 22:21:04 INFO - TinderboxPrint: I/O write bytes / time
413,069,312 / 277,172 22:21:04 INFO - TinderboxPrint: CPU idle
8,285.0 (86.7%) 22:21:04 INFO - TinderboxPrint: CPU user
1,219.6 (12.8%) 22:21:04 INFO - TinderboxPrint: Swap in / out
0 / 0 22:21:04 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 130138112; Read time: 112; Write time: 76160 22:21:04 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282390528; Read time: 88; Write time: 200980 22:21:04 INFO - Running post-run listener: _upload_blobber_files 22:21:04 INFO - Blob upload gear active. 22:21:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:21:04 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 22:21:04 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:21:04 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:21:05 INFO - (blobuploader) - INFO - Open directory for files ... 22:21:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:21:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:21:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:08 INFO - (blobuploader) - INFO - Done attempting. 22:21:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 22:21:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 22:21:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:09 INFO - (blobuploader) - INFO - Done attempting. 22:21:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 22:21:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:21:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:21:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 22:21:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:21:10 INFO - (blobuploader) - INFO - Done attempting. 22:21:10 INFO - (blobuploader) - INFO - Iteration through files over. 22:21:10 INFO - Return code: 0 22:21:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:21:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:21:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5cea82109f9262821215e30287a1f514da293f1dc67d82574bed0c946676ad8b5184cba9d3f089c948ef16bcf7b8b8679e1c908f584dbb5cfe560430045c756f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2c81bc8e18800e3419a72f57d65ff5204888e94467251c39acf97a81e9b30397bae1bab5de7bf5784ced0e61583b401d242a7187d0b9706c2b696b074693f973", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/32bcad2a20f7c937f19dd013ea4f8a8bf573e5090f834b8fb7631b8f8aba4cf3e11bbe92164522c960e370492c3ddf2da34d7fc84567df9ad968bdde5e28ee27"} 22:21:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:21:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:21:10 INFO - Contents: 22:21:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5cea82109f9262821215e30287a1f514da293f1dc67d82574bed0c946676ad8b5184cba9d3f089c948ef16bcf7b8b8679e1c908f584dbb5cfe560430045c756f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2c81bc8e18800e3419a72f57d65ff5204888e94467251c39acf97a81e9b30397bae1bab5de7bf5784ced0e61583b401d242a7187d0b9706c2b696b074693f973", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/32bcad2a20f7c937f19dd013ea4f8a8bf573e5090f834b8fb7631b8f8aba4cf3e11bbe92164522c960e370492c3ddf2da34d7fc84567df9ad968bdde5e28ee27"} 22:21:10 INFO - Running post-run listener: copy_logs_to_upload_dir 22:21:10 INFO - Copying logs to upload dir... 22:21:10 INFO - mkdir: /builds/slave/test/build/upload/logs 22:21:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.841590 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-08-12 22:21:09.296223) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 22:21:09.299671) ========= 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=31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5cea82109f9262821215e30287a1f514da293f1dc67d82574bed0c946676ad8b5184cba9d3f089c948ef16bcf7b8b8679e1c908f584dbb5cfe560430045c756f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2c81bc8e18800e3419a72f57d65ff5204888e94467251c39acf97a81e9b30397bae1bab5de7bf5784ced0e61583b401d242a7187d0b9706c2b696b074693f973", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/32bcad2a20f7c937f19dd013ea4f8a8bf573e5090f834b8fb7631b8f8aba4cf3e11bbe92164522c960e370492c3ddf2da34d7fc84567df9ad968bdde5e28ee27"} build_url:https://queue.taskcluster.net/v1/task/RK3EDr6jRZmg9dx--b-nYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011393 build_url: 'https://queue.taskcluster.net/v1/task/RK3EDr6jRZmg9dx--b-nYQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5cea82109f9262821215e30287a1f514da293f1dc67d82574bed0c946676ad8b5184cba9d3f089c948ef16bcf7b8b8679e1c908f584dbb5cfe560430045c756f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/2c81bc8e18800e3419a72f57d65ff5204888e94467251c39acf97a81e9b30397bae1bab5de7bf5784ced0e61583b401d242a7187d0b9706c2b696b074693f973", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/32bcad2a20f7c937f19dd013ea4f8a8bf573e5090f834b8fb7631b8f8aba4cf3e11bbe92164522c960e370492c3ddf2da34d7fc84567df9ad968bdde5e28ee27"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-12 22:21:09.329803) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 22:21:09.330574) ========= 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=31acecf42b6a79ec49471d4a000001bb-1471064195.883654-1589763312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-12 22:21:09.415130) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 22:21:09.415884) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-12 22:21:09.416539) ========= ========= Total master_lag: 0.18 =========