builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1471360550.34 results: success (0) buildid: 20160816070617 builduid: bc9bd1ee6eca4c358794b76dce63edea revision: 52fa735c7cec7333737999f62a43856e7306f6ba ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 08:15:50.345308) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-16 08:15:50.345812) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 08:15:50.346142) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-16 08:15:50.365959) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 08:15:50.366252) ========= 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=62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-16 08:15:50-- 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% 225M=0s 2016-08-16 08:15:50 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107530 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 08:15:50.488065) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 08:15:50.488439) ========= 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=62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018880 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 08:15:50.538592) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 08:15:50.538988) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 52fa735c7cec7333737999f62a43856e7306f6ba --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 52fa735c7cec7333737999f62a43856e7306f6ba --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=62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-16 08:15:50,905 truncating revision to first 12 chars 2016-08-16 08:15:50,905 Setting DEBUG logging. 2016-08-16 08:15:50,906 attempt 1/10 2016-08-16 08:15:50,906 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/52fa735c7cec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-16 08:15:51,231 unpacking tar archive at: fx-team-52fa735c7cec/testing/mozharness/ program finished with exit code 0 elapsedTime=0.666145 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 08:15:51.219649) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 08:15:51.220035) ========= script_repo_revision: 52fa735c7cec7333737999f62a43856e7306f6ba ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-16 08:15:51.221162) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 08:15:51.221486) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-16 08:15:51.231332) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-16 08:15:51.231679) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:15:51 INFO - MultiFileLogger online at 20160816 08:15:51 in /builds/slave/test 08:15:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:15:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:15:51 INFO - {'append_to_log': False, 08:15:51 INFO - 'base_work_dir': '/builds/slave/test', 08:15:51 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:15:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:15:51 INFO - 'branch': 'Fx-Team-Non-PGO', 08:15:51 INFO - 'buildbot_json_path': 'buildprops.json', 08:15:51 INFO - 'config_files': ('talos/linux_config.py',), 08:15:51 INFO - 'default_actions': ('clobber', 08:15:51 INFO - 'read-buildbot-config', 08:15:51 INFO - 'download-and-extract', 08:15:51 INFO - 'populate-webroot', 08:15:51 INFO - 'create-virtualenv', 08:15:51 INFO - 'install', 08:15:51 INFO - 'run-tests'), 08:15:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:15:51 INFO - 'download_minidump_stackwalk': True, 08:15:51 INFO - 'download_symbols': 'ondemand', 08:15:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:15:51 INFO - 'tooltool.py': '/tools/tooltool.py', 08:15:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:15:51 INFO - '/tools/misc-python/virtualenv.py')}, 08:15:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:15:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:15:51 INFO - 'installer_path': 'installer.exe', 08:15:51 INFO - 'log_level': 'info', 08:15:51 INFO - 'log_name': 'talos', 08:15:51 INFO - 'log_to_console': True, 08:15:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:15:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:15:51 INFO - 'opt_config_files': (), 08:15:51 INFO - 'pip_index': False, 08:15:51 INFO - 'sps_profile': False, 08:15:51 INFO - 'sps_profile_interval': 0, 08:15:51 INFO - 'suite': 'dromaeojs', 08:15:51 INFO - 'system_bits': '32', 08:15:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:15:51 INFO - 'title': 'talos-linux64-ix-018', 08:15:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:15:51 INFO - 'use_talos_json': True, 08:15:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:15:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:15:51 INFO - 'work_dir': 'build'} 08:15:51 INFO - [mozharness: 2016-08-16 15:15:51.701123Z] Running clobber step. 08:15:51 INFO - Running pre-action listener: _resource_record_pre_action 08:15:51 INFO - Running main action method: clobber 08:15:51 INFO - rmtree: /builds/slave/test/build 08:15:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:15:52 INFO - Running post-action listener: _resource_record_post_action 08:15:52 INFO - [mozharness: 2016-08-16 15:15:52.712167Z] Finished clobber step (success) 08:15:52 INFO - [mozharness: 2016-08-16 15:15:52.712266Z] Running read-buildbot-config step. 08:15:52 INFO - Running pre-action listener: _resource_record_pre_action 08:15:52 INFO - Running main action method: read_buildbot_config 08:15:52 INFO - Using buildbot properties: 08:15:52 INFO - { 08:15:52 INFO - "project": "", 08:15:52 INFO - "product": "firefox", 08:15:52 INFO - "script_repo_revision": "production", 08:15:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:15:52 INFO - "repository": "", 08:15:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:15:52 INFO - "buildid": "20160816070617", 08:15:52 INFO - "pgo_build": "False", 08:15:52 INFO - "basedir": "/builds/slave/test", 08:15:52 INFO - "buildnumber": 3237, 08:15:52 INFO - "slavename": "talos-linux64-ix-018", 08:15:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:15:52 INFO - "platform": "ubuntu64_hw", 08:15:52 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 08:15:52 INFO - "branch": "fx-team", 08:15:52 INFO - "repo_path": "integration/fx-team", 08:15:52 INFO - "revision": "52fa735c7cec7333737999f62a43856e7306f6ba", 08:15:52 INFO - "stage_platform": "linux64", 08:15:52 INFO - "builduid": "bc9bd1ee6eca4c358794b76dce63edea", 08:15:52 INFO - "slavebuilddir": "test" 08:15:52 INFO - } 08:15:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/EC09TPXmQlWkARIJzAJVzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 08:15:52 INFO - Running post-action listener: _resource_record_post_action 08:15:52 INFO - [mozharness: 2016-08-16 15:15:52.714677Z] Finished read-buildbot-config step (success) 08:15:52 INFO - [mozharness: 2016-08-16 15:15:52.714766Z] Running download-and-extract step. 08:15:52 INFO - Running pre-action listener: _resource_record_pre_action 08:15:52 INFO - Running main action method: download_and_extract 08:15:52 INFO - mkdir: /builds/slave/test/build/tests 08:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:52 INFO - trying https://queue.taskcluster.net/v1/task/EC09TPXmQlWkARIJzAJVzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:15:52 INFO - Downloading https://queue.taskcluster.net/v1/task/EC09TPXmQlWkARIJzAJVzw/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 08:15:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EC09TPXmQlWkARIJzAJVzw/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 08:15:53 INFO - Downloaded 1361 bytes. 08:15:53 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 08:15:53 INFO - Using the following test package requirements: 08:15:53 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:15:53 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:15:53 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:15:53 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:53 INFO - u'jsshell-linux-x86_64.zip'], 08:15:53 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:15:53 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 08:15:53 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:15:53 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:15:53 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:15:53 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 08:15:53 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:15:53 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:15:53 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')]} 08:15:53 INFO - trying https://queue.taskcluster.net/v1/task/EC09TPXmQlWkARIJzAJVzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:15:53 INFO - Downloading https://queue.taskcluster.net/v1/task/EC09TPXmQlWkARIJzAJVzw/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 08:15:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EC09TPXmQlWkARIJzAJVzw/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 08:15:54 INFO - Downloaded 20265717 bytes. 08:15:54 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 08:15:58 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 08:15:58 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')]} 08:15:58 INFO - trying https://queue.taskcluster.net/v1/task/EC09TPXmQlWkARIJzAJVzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 08:15:58 INFO - Downloading https://queue.taskcluster.net/v1/task/EC09TPXmQlWkARIJzAJVzw/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 08:15:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EC09TPXmQlWkARIJzAJVzw/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 08:15:59 INFO - Downloaded 20265717 bytes. 08:15:59 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 08:16:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:03 INFO - trying https://queue.taskcluster.net/v1/task/EC09TPXmQlWkARIJzAJVzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 08:16:03 INFO - Downloading https://queue.taskcluster.net/v1/task/EC09TPXmQlWkARIJzAJVzw/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 08:16:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EC09TPXmQlWkARIJzAJVzw/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 08:16:04 INFO - Downloaded 14413719 bytes. 08:16:04 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 08:16: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')]} 08:16:04 INFO - trying https://queue.taskcluster.net/v1/task/EC09TPXmQlWkARIJzAJVzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:16:04 INFO - Downloading https://queue.taskcluster.net/v1/task/EC09TPXmQlWkARIJzAJVzw/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 08:16:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EC09TPXmQlWkARIJzAJVzw/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 08:16:05 INFO - Downloaded 55628184 bytes. 08:16:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EC09TPXmQlWkARIJzAJVzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:16:05 INFO - mkdir: /builds/slave/test/properties 08:16:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:16:05 INFO - Writing to file /builds/slave/test/properties/build_url 08:16:05 INFO - Contents: 08:16:05 INFO - build_url:https://queue.taskcluster.net/v1/task/EC09TPXmQlWkARIJzAJVzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 08:16:06 INFO - Running post-action listener: _resource_record_post_action 08:16:06 INFO - Running post-action listener: set_extra_try_arguments 08:16:06 INFO - [mozharness: 2016-08-16 15:16:06.431841Z] Finished download-and-extract step (success) 08:16:06 INFO - [mozharness: 2016-08-16 15:16:06.432065Z] Running populate-webroot step. 08:16:06 INFO - Running pre-action listener: _resource_record_pre_action 08:16:06 INFO - Running main action method: populate_webroot 08:16:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:16:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:16:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:16:06 INFO - '--tppagecycles', 08:16:06 INFO - '7'], 08:16:06 INFO - 'tests': ['tsvgm']}}, 08:16:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:16:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:16:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:16:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:16:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:16:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:16:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:06 INFO - 'talos_options': ['--disable-e10s'], 08:16:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:16:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:16:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:06 INFO - 'talos_options': ['--disable-e10s'], 08:16:06 INFO - 'tests': ['damp', 'tps']}, 08:16:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:06 INFO - 'tests': ['damp', 'tps']}, 08:16:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:16:06 INFO - 'tests': ['dromaeo_dom']}, 08:16:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:16:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:16:06 INFO - 'tests': ['basic_compositor_video']}, 08:16:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:16:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:16:06 INFO - 'tests': ['a11yr', 08:16:06 INFO - 'ts_paint', 08:16:06 INFO - 'tpaint', 08:16:06 INFO - 'sessionrestore', 08:16:06 INFO - 'sessionrestore_no_auto_restore', 08:16:06 INFO - 'tabpaint']}, 08:16:06 INFO - 'other-e10s': {'tests': ['a11yr', 08:16:06 INFO - 'ts_paint', 08:16:06 INFO - 'tpaint', 08:16:06 INFO - 'sessionrestore', 08:16:06 INFO - 'sessionrestore_no_auto_restore', 08:16:06 INFO - 'tabpaint']}, 08:16:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:16:06 INFO - 'ts_paint', 08:16:06 INFO - 'tpaint', 08:16:06 INFO - 'sessionrestore', 08:16:06 INFO - 'sessionrestore_no_auto_restore', 08:16:06 INFO - 'tabpaint']}, 08:16:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:16:06 INFO - 'ts_paint', 08:16:06 INFO - 'tpaint', 08:16:06 INFO - 'sessionrestore', 08:16:06 INFO - 'sessionrestore_no_auto_restore', 08:16:06 INFO - 'tabpaint']}, 08:16:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:16:06 INFO - 'tests': ['a11yr', 08:16:06 INFO - 'ts_paint', 08:16:06 INFO - 'tpaint', 08:16:06 INFO - 'sessionrestore', 08:16:06 INFO - 'sessionrestore_no_auto_restore', 08:16:06 INFO - 'tabpaint']}, 08:16:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:16:06 INFO - 'tests': ['a11yr', 08:16:06 INFO - 'ts_paint', 08:16:06 INFO - 'tpaint', 08:16:06 INFO - 'sessionrestore', 08:16:06 INFO - 'sessionrestore_no_auto_restore', 08:16:06 INFO - 'tabpaint']}, 08:16:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:16:06 INFO - 'tests': ['tsvgx', 08:16:06 INFO - 'tsvgr_opacity', 08:16:06 INFO - 'tart', 08:16:06 INFO - 'tscrollx', 08:16:06 INFO - 'cart']}, 08:16:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:16:06 INFO - 'tsvgr_opacity', 08:16:06 INFO - 'tart', 08:16:06 INFO - 'tscrollx', 08:16:06 INFO - 'cart']}, 08:16:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:06 INFO - 'talos_options': ['--disable-e10s'], 08:16:06 INFO - 'tests': ['tp5o']}, 08:16:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:06 INFO - 'tests': ['tp5o']}, 08:16:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:06 INFO - 'talos_options': ['--disable-e10s', 08:16:06 INFO - '--xperf_path', 08:16:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:16:06 INFO - 'tests': ['tp5n']}, 08:16:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:06 INFO - 'talos_options': ['--xperf_path', 08:16:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:16:06 INFO - 'tests': ['tp5n']}}, 08:16:06 INFO - 'talos.zip': {'path': '', 08:16:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:16:06 INFO - Running post-action listener: _resource_record_post_action 08:16:06 INFO - [mozharness: 2016-08-16 15:16:06.453616Z] Finished populate-webroot step (success) 08:16:06 INFO - [mozharness: 2016-08-16 15:16:06.453705Z] Running create-virtualenv step. 08:16:06 INFO - Running pre-action listener: _resource_record_pre_action 08:16:06 INFO - Running main action method: create_virtualenv 08:16:06 INFO - Creating virtualenv /builds/slave/test/build/venv 08:16:06 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 08:16:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:16:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:16:06 INFO - Using real prefix '/usr' 08:16:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:16:07 INFO - Installing distribute.............................................................................................................................................................................................done. 08:16:09 INFO - Installing pip.................done. 08:16:09 INFO - Return code: 0 08:16:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2152475f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9b090>, '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 0x2a9e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ee40>, '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': '62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865', '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 08:16:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:16:09 INFO - Using env: {'DISPLAY': ':0', 08:16:09 INFO - 'HOME': '/home/cltbld', 08:16:09 INFO - 'LANG': 'en_US.UTF-8', 08:16:09 INFO - 'LANGUAGE': 'en_US:en', 08:16:09 INFO - 'LOGNAME': 'cltbld', 08:16:09 INFO - 'MAIL': '/var/mail/cltbld', 08:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:09 INFO - 'MOZ_NO_REMOTE': '1', 08:16:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:09 INFO - 'NO_EM_RESTART': '1', 08:16:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:09 INFO - 'PWD': '/builds/slave/test', 08:16:09 INFO - 'SHELL': '/bin/bash', 08:16:09 INFO - 'SHLVL': '1', 08:16:09 INFO - 'TERM': 'linux', 08:16:09 INFO - 'TMOUT': '86400', 08:16:09 INFO - 'USER': 'cltbld', 08:16:09 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865', 08:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:09 INFO - '_': '/tools/buildbot/bin/python'} 08:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:09 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 08:16:09 INFO - Cleaning up... 08:16:09 INFO - Return code: 0 08:16:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2152475f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9b090>, '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 0x2a9e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ee40>, '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': '62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865', '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 08:16:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:16:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:16:09 INFO - Using env: {'DISPLAY': ':0', 08:16:09 INFO - 'HOME': '/home/cltbld', 08:16:09 INFO - 'LANG': 'en_US.UTF-8', 08:16:09 INFO - 'LANGUAGE': 'en_US:en', 08:16:09 INFO - 'LOGNAME': 'cltbld', 08:16:09 INFO - 'MAIL': '/var/mail/cltbld', 08:16:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:09 INFO - 'MOZ_NO_REMOTE': '1', 08:16:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:09 INFO - 'NO_EM_RESTART': '1', 08:16:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:09 INFO - 'PWD': '/builds/slave/test', 08:16:09 INFO - 'SHELL': '/bin/bash', 08:16:09 INFO - 'SHLVL': '1', 08:16:09 INFO - 'TERM': 'linux', 08:16:09 INFO - 'TMOUT': '86400', 08:16:09 INFO - 'USER': 'cltbld', 08:16:09 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865', 08:16:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:09 INFO - '_': '/tools/buildbot/bin/python'} 08:16:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:09 INFO - Downloading/unpacking psutil>=3.1.1 08:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:16:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:16:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:16:11 INFO - Installing collected packages: psutil 08:16:11 INFO - Running setup.py install for psutil 08:16:11 INFO - building 'psutil._psutil_linux' extension 08:16:11 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 08:16:11 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 08:16:11 INFO - building 'psutil._psutil_posix' extension 08:16:11 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 08:16:11 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 08:16:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:16:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:16:11 INFO - Successfully installed psutil 08:16:11 INFO - Cleaning up... 08:16:11 INFO - Return code: 0 08:16:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:16:11 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')]} 08:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:11 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')]} 08:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:11 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 0x7f2152475f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9b090>, '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 0x2a9e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ee40>, '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': '62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865', '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 08:16:11 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 08:16:11 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 08:16:11 INFO - Using env: {'DISPLAY': ':0', 08:16:11 INFO - 'HOME': '/home/cltbld', 08:16:11 INFO - 'LANG': 'en_US.UTF-8', 08:16:11 INFO - 'LANGUAGE': 'en_US:en', 08:16:11 INFO - 'LOGNAME': 'cltbld', 08:16:11 INFO - 'MAIL': '/var/mail/cltbld', 08:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:11 INFO - 'MOZ_NO_REMOTE': '1', 08:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:11 INFO - 'NO_EM_RESTART': '1', 08:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:11 INFO - 'PWD': '/builds/slave/test', 08:16:11 INFO - 'SHELL': '/bin/bash', 08:16:11 INFO - 'SHLVL': '1', 08:16:11 INFO - 'TERM': 'linux', 08:16:11 INFO - 'TMOUT': '86400', 08:16:11 INFO - 'USER': 'cltbld', 08:16:11 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865', 08:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:11 INFO - '_': '/tools/buildbot/bin/python'} 08:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:16:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:16:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:16:14 INFO - Installing collected packages: mozsystemmonitor 08:16:14 INFO - Running setup.py install for mozsystemmonitor 08:16:14 INFO - Successfully installed mozsystemmonitor 08:16:14 INFO - Cleaning up... 08:16:14 INFO - Return code: 0 08:16:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:16:14 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')]} 08:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:14 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')]} 08:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.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 0x7f2152475f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9b090>, '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 0x2a9e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ee40>, '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': '62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865', '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 08:16:14 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 08:16:14 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 08:16:14 INFO - Using env: {'DISPLAY': ':0', 08:16:14 INFO - 'HOME': '/home/cltbld', 08:16:14 INFO - 'LANG': 'en_US.UTF-8', 08:16:14 INFO - 'LANGUAGE': 'en_US:en', 08:16:14 INFO - 'LOGNAME': 'cltbld', 08:16:14 INFO - 'MAIL': '/var/mail/cltbld', 08:16:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:14 INFO - 'MOZ_NO_REMOTE': '1', 08:16:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:14 INFO - 'NO_EM_RESTART': '1', 08:16:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:14 INFO - 'PWD': '/builds/slave/test', 08:16:14 INFO - 'SHELL': '/bin/bash', 08:16:14 INFO - 'SHLVL': '1', 08:16:14 INFO - 'TERM': 'linux', 08:16:14 INFO - 'TMOUT': '86400', 08:16:14 INFO - 'USER': 'cltbld', 08:16:14 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865', 08:16:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:14 INFO - '_': '/tools/buildbot/bin/python'} 08:16:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:14 INFO - Downloading/unpacking jsonschema==2.5.1 08:16:14 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 08:16:14 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 08:16:14 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 08:16:14 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 08:16:14 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 08:16:14 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 08:16:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:16:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:16:16 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 08:16:16 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 08:16:16 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 08:16:16 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 08:16:16 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 08:16:16 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 08:16:16 INFO - Downloading functools32-3.2.3-2.tar.gz 08:16:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:16:16 INFO - warning: no files found matching '*.txt' 08:16:16 INFO - no previously-included directories found matching 'build' 08:16:16 INFO - no previously-included directories found matching 'dist' 08:16:16 INFO - no previously-included directories found matching '.git*' 08:16:16 INFO - Installing collected packages: jsonschema, functools32 08:16:16 INFO - Running setup.py install for functools32 08:16:16 INFO - warning: no files found matching '*.txt' 08:16:16 INFO - no previously-included directories found matching 'build' 08:16:16 INFO - no previously-included directories found matching 'dist' 08:16:16 INFO - no previously-included directories found matching '.git*' 08:16:16 INFO - Successfully installed jsonschema functools32 08:16:16 INFO - Cleaning up... 08:16:16 INFO - Return code: 0 08:16:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:16:16 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')]} 08:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:16 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')]} 08:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:16 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 0x7f2152475f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9b090>, '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 0x2a9e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ee40>, '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': '62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865', '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 08:16:16 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 08:16:16 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 08:16:16 INFO - Using env: {'DISPLAY': ':0', 08:16:16 INFO - 'HOME': '/home/cltbld', 08:16:16 INFO - 'LANG': 'en_US.UTF-8', 08:16:16 INFO - 'LANGUAGE': 'en_US:en', 08:16:16 INFO - 'LOGNAME': 'cltbld', 08:16:16 INFO - 'MAIL': '/var/mail/cltbld', 08:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:16 INFO - 'MOZ_NO_REMOTE': '1', 08:16:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:16 INFO - 'NO_EM_RESTART': '1', 08:16:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:16 INFO - 'PWD': '/builds/slave/test', 08:16:16 INFO - 'SHELL': '/bin/bash', 08:16:16 INFO - 'SHLVL': '1', 08:16:16 INFO - 'TERM': 'linux', 08:16:16 INFO - 'TMOUT': '86400', 08:16:16 INFO - 'USER': 'cltbld', 08:16:16 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865', 08:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:16 INFO - '_': '/tools/buildbot/bin/python'} 08:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:16:17 INFO - Cleaning up... 08:16:17 INFO - Return code: 0 08:16:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:17 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 0x7f2152475f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9b090>, '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 0x2a9e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ee40>, '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': '62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865', '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 08:16:17 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 08:16:17 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 08:16:17 INFO - Using env: {'DISPLAY': ':0', 08:16:17 INFO - 'HOME': '/home/cltbld', 08:16:17 INFO - 'LANG': 'en_US.UTF-8', 08:16:17 INFO - 'LANGUAGE': 'en_US:en', 08:16:17 INFO - 'LOGNAME': 'cltbld', 08:16:17 INFO - 'MAIL': '/var/mail/cltbld', 08:16:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:17 INFO - 'MOZ_NO_REMOTE': '1', 08:16:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:17 INFO - 'NO_EM_RESTART': '1', 08:16:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:17 INFO - 'PWD': '/builds/slave/test', 08:16:17 INFO - 'SHELL': '/bin/bash', 08:16:17 INFO - 'SHLVL': '1', 08:16:17 INFO - 'TERM': 'linux', 08:16:17 INFO - 'TMOUT': '86400', 08:16:17 INFO - 'USER': 'cltbld', 08:16:17 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865', 08:16:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:17 INFO - '_': '/tools/buildbot/bin/python'} 08:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:17 INFO - Downloading/unpacking blobuploader==1.2.4 08:16:17 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 08:16:17 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 08:16:17 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 08:16:17 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 08:16:17 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 08:16:17 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 08:16:19 INFO - Downloading blobuploader-1.2.4.tar.gz 08:16:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:16:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:16:19 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 08:16:19 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 08:16:19 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 08:16:19 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 08:16:19 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 08:16:19 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 08:16:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:16:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:16:19 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 08:16:19 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 08:16:19 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 08:16:19 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 08:16:19 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 08:16:19 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 08:16:19 INFO - Downloading docopt-0.6.1.tar.gz 08:16:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:16:19 INFO - Installing collected packages: blobuploader, requests, docopt 08:16:19 INFO - Running setup.py install for blobuploader 08:16:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:16:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:16:19 INFO - Running setup.py install for requests 08:16:20 INFO - Running setup.py install for docopt 08:16:20 INFO - Successfully installed blobuploader requests docopt 08:16:20 INFO - Cleaning up... 08:16:20 INFO - Return code: 0 08:16:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:20 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 0x7f2152475f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9b090>, '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 0x2a9e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ee40>, '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': '62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865', '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 08:16:20 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 08:16:20 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 08:16:20 INFO - Using env: {'DISPLAY': ':0', 08:16:20 INFO - 'HOME': '/home/cltbld', 08:16:20 INFO - 'LANG': 'en_US.UTF-8', 08:16:20 INFO - 'LANGUAGE': 'en_US:en', 08:16:20 INFO - 'LOGNAME': 'cltbld', 08:16:20 INFO - 'MAIL': '/var/mail/cltbld', 08:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:20 INFO - 'MOZ_NO_REMOTE': '1', 08:16:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:20 INFO - 'NO_EM_RESTART': '1', 08:16:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:20 INFO - 'PWD': '/builds/slave/test', 08:16:20 INFO - 'SHELL': '/bin/bash', 08:16:20 INFO - 'SHLVL': '1', 08:16:20 INFO - 'TERM': 'linux', 08:16:20 INFO - 'TMOUT': '86400', 08:16:20 INFO - 'USER': 'cltbld', 08:16:20 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865', 08:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:20 INFO - '_': '/tools/buildbot/bin/python'} 08:16:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:16:20 INFO - Running setup.py (path:/tmp/pip-nKJ7rf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:16:20 INFO - Running setup.py (path:/tmp/pip-pNN9g0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:16:20 INFO - Running setup.py (path:/tmp/pip-du4K3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:16:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:16:20 INFO - Running setup.py (path:/tmp/pip-L3Jq2d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:16:21 INFO - Running setup.py (path:/tmp/pip-l4Xbmc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:16:21 INFO - Running setup.py (path:/tmp/pip-LJvik7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:16:21 INFO - Running setup.py (path:/tmp/pip-C_2936-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:16:21 INFO - Running setup.py (path:/tmp/pip-kyzqvt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:16:21 INFO - Running setup.py (path:/tmp/pip-pK2fC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:16:21 INFO - Running setup.py (path:/tmp/pip-OLZHRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:16:21 INFO - Running setup.py (path:/tmp/pip-zC4rYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:16:21 INFO - Running setup.py (path:/tmp/pip-q4hq_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:16:21 INFO - Running setup.py (path:/tmp/pip-GljNNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:16:21 INFO - Running setup.py (path:/tmp/pip-DiTQCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:21 INFO - Running setup.py (path:/tmp/pip-Dn9guN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:16:21 INFO - Running setup.py (path:/tmp/pip-NPmAcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:16:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:16:21 INFO - Running setup.py (path:/tmp/pip-QEAgvy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:16:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:16:21 INFO - Running setup.py install for manifestparser 08:16:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:16:22 INFO - Running setup.py install for mozcrash 08:16:22 INFO - Running setup.py install for mozdebug 08:16:22 INFO - Running setup.py install for mozdevice 08:16:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:16:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:16:22 INFO - Running setup.py install for mozfile 08:16:22 INFO - Running setup.py install for mozhttpd 08:16:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:16:22 INFO - Running setup.py install for mozinfo 08:16:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:16:22 INFO - Running setup.py install for mozInstall 08:16:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:16:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:16:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:16:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:16:22 INFO - Running setup.py install for mozleak 08:16:22 INFO - Running setup.py install for mozlog 08:16:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:16:22 INFO - Running setup.py install for moznetwork 08:16:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:16:23 INFO - Running setup.py install for mozprocess 08:16:23 INFO - Running setup.py install for mozprofile 08:16:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:16:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:16:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:16:23 INFO - Running setup.py install for mozrunner 08:16:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:16:23 INFO - Running setup.py install for mozscreenshot 08:16:23 INFO - Running setup.py install for moztest 08:16:23 INFO - Running setup.py install for mozversion 08:16:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:16:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:16:23 INFO - Cleaning up... 08:16:23 INFO - Return code: 0 08:16:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:23 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')]} 08:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:23 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')]} 08:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:23 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 0x7f2152475f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9b090>, '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 0x2a9e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ee40>, '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': '62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865', '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 08:16:23 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 08:16:23 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 08:16:23 INFO - Using env: {'DISPLAY': ':0', 08:16:23 INFO - 'HOME': '/home/cltbld', 08:16:23 INFO - 'LANG': 'en_US.UTF-8', 08:16:23 INFO - 'LANGUAGE': 'en_US:en', 08:16:23 INFO - 'LOGNAME': 'cltbld', 08:16:23 INFO - 'MAIL': '/var/mail/cltbld', 08:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:23 INFO - 'MOZ_NO_REMOTE': '1', 08:16:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:23 INFO - 'NO_EM_RESTART': '1', 08:16:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:23 INFO - 'PWD': '/builds/slave/test', 08:16:23 INFO - 'SHELL': '/bin/bash', 08:16:23 INFO - 'SHLVL': '1', 08:16:23 INFO - 'TERM': 'linux', 08:16:23 INFO - 'TMOUT': '86400', 08:16:23 INFO - 'USER': 'cltbld', 08:16:23 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865', 08:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:23 INFO - '_': '/tools/buildbot/bin/python'} 08:16:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:16:23 INFO - Running setup.py (path:/tmp/pip-eYjDL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:16:24 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)) 08:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:16:24 INFO - Running setup.py (path:/tmp/pip-sXdptY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:16:24 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)) 08:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:16:24 INFO - Running setup.py (path:/tmp/pip-oCODpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:16:24 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)) 08:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:16:24 INFO - Running setup.py (path:/tmp/pip-hgVhJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:16:24 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)) 08:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:16:24 INFO - Running setup.py (path:/tmp/pip-fCCrVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:16:24 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)) 08:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:16:24 INFO - Running setup.py (path:/tmp/pip-MN9IyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:16:24 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)) 08:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:16:24 INFO - Running setup.py (path:/tmp/pip-76ZGTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:16:24 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)) 08:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:16:24 INFO - Running setup.py (path:/tmp/pip-X4Njd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:16:24 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)) 08:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:16:24 INFO - Running setup.py (path:/tmp/pip-_iRsLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:16:24 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)) 08:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:16:24 INFO - Running setup.py (path:/tmp/pip-XLVTbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:16:24 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)) 08:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:16:24 INFO - Running setup.py (path:/tmp/pip-j000Ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:16:24 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)) 08:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:16:24 INFO - Running setup.py (path:/tmp/pip-bWJSBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:16:24 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)) 08:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:16:24 INFO - Running setup.py (path:/tmp/pip-AkkGMH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:16:24 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)) 08:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:16:24 INFO - Running setup.py (path:/tmp/pip-xl34rO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:16:24 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)) 08:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:24 INFO - Running setup.py (path:/tmp/pip-UyRIIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:25 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)) 08:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:16:25 INFO - Running setup.py (path:/tmp/pip-PdHGXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:16:25 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)) 08:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:16:25 INFO - Running setup.py (path:/tmp/pip-ifOljI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:16:25 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)) 08:16:25 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)) 08:16:25 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)) 08:16:25 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)) 08:16:25 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)) 08:16:25 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)) 08:16:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:27 INFO - Downloading blessings-1.6.tar.gz 08:16:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:16:27 INFO - Installing collected packages: blessings 08:16:27 INFO - Running setup.py install for blessings 08:16:27 INFO - Successfully installed blessings 08:16:27 INFO - Cleaning up... 08:16:27 INFO - Return code: 0 08:16:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:16:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:16:27 INFO - Reading from file tmpfile_stdout 08:16:27 INFO - Current package versions: 08:16:27 INFO - argparse == 1.2.1 08:16:27 INFO - blessings == 1.6 08:16:27 INFO - blobuploader == 1.2.4 08:16:27 INFO - docopt == 0.6.1 08:16:27 INFO - functools32 == 3.2.3-2 08:16:27 INFO - jsonschema == 2.5.1 08:16:27 INFO - manifestparser == 1.1 08:16:27 INFO - mozInstall == 1.12 08:16:27 INFO - mozcrash == 0.17 08:16:27 INFO - mozdebug == 0.1 08:16:27 INFO - mozdevice == 0.48 08:16:27 INFO - mozfile == 1.2 08:16:27 INFO - mozhttpd == 0.7 08:16:27 INFO - mozinfo == 0.9 08:16:27 INFO - mozleak == 0.1 08:16:27 INFO - mozlog == 3.3 08:16:27 INFO - moznetwork == 0.27 08:16:27 INFO - mozprocess == 0.23 08:16:27 INFO - mozprofile == 0.28 08:16:27 INFO - mozrunner == 6.12 08:16:27 INFO - mozscreenshot == 0.1 08:16:27 INFO - mozsystemmonitor == 0.3 08:16:27 INFO - moztest == 0.7 08:16:27 INFO - mozversion == 1.4 08:16:27 INFO - psutil == 3.1.1 08:16:27 INFO - requests == 1.2.3 08:16:27 INFO - wsgiref == 0.1.2 08:16:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:27 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')]} 08:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:27 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')]} 08:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:27 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 0x7f2152475f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9b090>, '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 0x2a9e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ee40>, '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': '62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865', '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 08:16:27 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 08:16:27 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 08:16:27 INFO - Using env: {'DISPLAY': ':0', 08:16:27 INFO - 'HOME': '/home/cltbld', 08:16:27 INFO - 'LANG': 'en_US.UTF-8', 08:16:27 INFO - 'LANGUAGE': 'en_US:en', 08:16:27 INFO - 'LOGNAME': 'cltbld', 08:16:27 INFO - 'MAIL': '/var/mail/cltbld', 08:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:27 INFO - 'MOZ_NO_REMOTE': '1', 08:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:27 INFO - 'NO_EM_RESTART': '1', 08:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:27 INFO - 'PWD': '/builds/slave/test', 08:16:27 INFO - 'SHELL': '/bin/bash', 08:16:27 INFO - 'SHLVL': '1', 08:16:27 INFO - 'TERM': 'linux', 08:16:27 INFO - 'TMOUT': '86400', 08:16:27 INFO - 'USER': 'cltbld', 08:16:27 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865', 08:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:27 INFO - '_': '/tools/buildbot/bin/python'} 08:16:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:27 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)) 08:16:27 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)) 08:16:27 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)) 08:16:27 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)) 08:16:27 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)) 08:16:27 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)) 08:16:27 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)) 08:16:27 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)) 08:16:27 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)) 08:16:27 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)) 08:16:27 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)) 08:16:27 INFO - Cleaning up... 08:16:27 INFO - Return code: 0 08:16:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:16:27 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')]} 08:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:27 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')]} 08:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:27 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 0x7f2152475f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29d28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aa1230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a9b090>, '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 0x2a9e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ee40>, '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': '62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865', '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 08:16:27 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 08:16:27 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 08:16:27 INFO - Using env: {'DISPLAY': ':0', 08:16:27 INFO - 'HOME': '/home/cltbld', 08:16:27 INFO - 'LANG': 'en_US.UTF-8', 08:16:27 INFO - 'LANGUAGE': 'en_US:en', 08:16:27 INFO - 'LOGNAME': 'cltbld', 08:16:27 INFO - 'MAIL': '/var/mail/cltbld', 08:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:27 INFO - 'MOZ_NO_REMOTE': '1', 08:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:27 INFO - 'NO_EM_RESTART': '1', 08:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:27 INFO - 'PWD': '/builds/slave/test', 08:16:27 INFO - 'SHELL': '/bin/bash', 08:16:27 INFO - 'SHLVL': '1', 08:16:27 INFO - 'TERM': 'linux', 08:16:27 INFO - 'TMOUT': '86400', 08:16:27 INFO - 'USER': 'cltbld', 08:16:27 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865', 08:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:27 INFO - '_': '/tools/buildbot/bin/python'} 08:16:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:16:27 INFO - Cleaning up... 08:16:27 INFO - Return code: 0 08:16:27 INFO - Running post-action listener: _resource_record_post_action 08:16:27 INFO - Running post-action listener: _start_resource_monitoring 08:16:27 INFO - Starting resource monitoring. 08:16:27 INFO - [mozharness: 2016-08-16 15:16:27.980565Z] Finished create-virtualenv step (success) 08:16:27 INFO - [mozharness: 2016-08-16 15:16:27.981034Z] Running install step. 08:16:27 INFO - Running pre-action listener: _resource_record_pre_action 08:16:27 INFO - Running main action method: install 08:16:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:16:28 INFO - Reading from file tmpfile_stdout 08:16:28 INFO - Detecting whether we're running mozinstall >=1.0... 08:16:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:16:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:16:28 INFO - Reading from file tmpfile_stdout 08:16:28 INFO - Output received: 08:16:28 INFO - Usage: mozinstall [options] installer 08:16:28 INFO - Options: 08:16:28 INFO - -h, --help show this help message and exit 08:16:28 INFO - -d DEST, --destination=DEST 08:16:28 INFO - Directory to install application into. [default: 08:16:28 INFO - "/builds/slave/test"] 08:16:28 INFO - --app=APP Application being installed. [default: firefox] 08:16:28 INFO - mkdir: /builds/slave/test/build/application 08:16:28 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'] 08:16:28 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 08:16:44 INFO - Reading from file tmpfile_stdout 08:16:44 INFO - Output received: 08:16:44 INFO - /builds/slave/test/build/application/firefox/firefox 08:16:44 INFO - Running post-action listener: _resource_record_post_action 08:16:44 INFO - [mozharness: 2016-08-16 15:16:44.316549Z] Finished install step (success) 08:16:44 INFO - [mozharness: 2016-08-16 15:16:44.316796Z] Running run-tests step. 08:16:44 INFO - Running pre-action listener: _resource_record_pre_action 08:16:44 INFO - Running main action method: run_tests 08:16:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:16:44 INFO - Python 2.7.3 08:16:44 INFO - Return code: 0 08:16:44 INFO - grabbing minidump binary from tooltool 08:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:44 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 0x2a9b090>, '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 0x2a9e9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a9ee40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:16:44 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 08:16:44 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 08:16:44 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 08:16:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:16:44 INFO - Return code: 0 08:16:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:16:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:16:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:16:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:16:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:16:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EC09TPXmQlWkARIJzAJVzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:16:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EC09TPXmQlWkARIJzAJVzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:16:44 INFO - Using env: {'DISPLAY': ':0', 08:16:44 INFO - 'HOME': '/home/cltbld', 08:16:44 INFO - 'LANG': 'en_US.UTF-8', 08:16:44 INFO - 'LANGUAGE': 'en_US:en', 08:16:44 INFO - 'LOGNAME': 'cltbld', 08:16:44 INFO - 'MAIL': '/var/mail/cltbld', 08:16:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:16:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:44 INFO - 'MOZ_NO_REMOTE': '1', 08:16:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:44 INFO - 'NO_EM_RESTART': '1', 08:16:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:44 INFO - 'PWD': '/builds/slave/test', 08:16:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:16:44 INFO - 'SHELL': '/bin/bash', 08:16:44 INFO - 'SHLVL': '1', 08:16:44 INFO - 'TERM': 'linux', 08:16:44 INFO - 'TMOUT': '86400', 08:16:44 INFO - 'USER': 'cltbld', 08:16:44 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865', 08:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:44 INFO - '_': '/tools/buildbot/bin/python'} 08:16:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EC09TPXmQlWkARIJzAJVzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:16:44 INFO - mozversion application_buildid: 20160816070617 08:16:44 INFO - mozversion application_changeset: 52fa735c7cec7333737999f62a43856e7306f6ba 08:16:44 INFO - mozversion application_display_name: Nightly 08:16:44 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:16:44 INFO - mozversion application_name: Firefox 08:16:44 INFO - mozversion application_remotingname: firefox 08:16:44 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:16:44 INFO - mozversion application_vendor: Mozilla 08:16:44 INFO - mozversion application_version: 51.0a1 08:16:44 INFO - mozversion platform_buildid: 20160816070617 08:16:44 INFO - mozversion platform_changeset: 52fa735c7cec7333737999f62a43856e7306f6ba 08:16:44 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:16:44 INFO - mozversion platform_version: 51.0a1 08:16:44 INFO - using testdate: 1471360604 08:16:44 INFO - actual date: 1471360604 08:16:44 INFO - starting webserver on 'localhost:39676' 08:16:44 INFO - SUITE-START | Running 2 tests 08:16:44 INFO - TEST-START | dromaeo_css 08:16:44 INFO - operating with platform_type : linux_ 08:16:44 INFO - Initialising browser for dromaeo_css test... 08:16:44 INFO - TEST-INFO | started process 22127 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnTx2uC/profile http://localhost:39676/getInfo.html) 08:16:48 INFO - PROCESS | 22127 | __metrics Screen width/height:1600/1200 08:16:48 INFO - PROCESS | 22127 | colorDepth:24 08:16:48 INFO - PROCESS | 22127 | Browser inner width/height: 1024/697 08:16:48 INFO - PROCESS | 22127 | __metrics 08:16:49 INFO - PROCESS | 22127 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:16:49 INFO - PROCESS | 22127 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:16:49 INFO - PROCESS | 22127 | console.error: PushService: 08:16:49 INFO - PROCESS | 22127 | stateChangeProcessEnqueue: Error transitioning state 08:16:49 INFO - PROCESS | 22127 | UnknownError 08:16:50 INFO - TEST-INFO | 22127: exit 0 08:16:50 INFO - Browser initialized. 08:16:50 INFO - Running cycle 1/1 for dromaeo_css test... 08:16:50 INFO - TEST-INFO | started process 22207 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnTx2uC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:17:02 INFO - PROCESS | 22207 | RSS: Main: 157483008 08:17:02 INFO - PROCESS | 22207 | 08:17:53 INFO - PROCESS | 22207 | 1471360673417 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] 08:20:06 INFO - PROCESS | 22207 | Cycle 1(1): loaded http://localhost:39676/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39676/tests/dromaeo/cssquery-ext.html) 08:20:07 INFO - PROCESS | 22207 | RSS: Main: 245227520 08:20:07 INFO - PROCESS | 22207 | 08:23:10 INFO - PROCESS | 22207 | Cycle 1(1): loaded http://localhost:39676/tests/dromaeo/cssquery-ext.html (next: http://localhost:39676/tests/dromaeo/cssquery-jquery.html) 08:23:10 INFO - PROCESS | 22207 | RSS: Main: 247054336 08:23:10 INFO - PROCESS | 22207 | 08:26:13 INFO - PROCESS | 22207 | Cycle 1(1): loaded http://localhost:39676/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39676/tests/dromaeo/cssquery-mootools.html) 08:26:13 INFO - PROCESS | 22207 | RSS: Main: 189603840 08:26:13 INFO - PROCESS | 22207 | 08:29:16 INFO - PROCESS | 22207 | Cycle 1(1): loaded http://localhost:39676/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39676/tests/dromaeo/cssquery-prototype.html) 08:29:16 INFO - PROCESS | 22207 | RSS: Main: 189612032 08:29:16 INFO - PROCESS | 22207 | 08:32:19 INFO - PROCESS | 22207 | Cycle 1(1): loaded http://localhost:39676/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39676/tests/dromaeo/cssquery-yui.html) 08:32:20 INFO - PROCESS | 22207 | RSS: Main: 191987712 08:32:20 INFO - PROCESS | 22207 | 08:35:23 INFO - PROCESS | 22207 | Cycle 1(1): loaded http://localhost:39676/tests/dromaeo/cssquery-yui.html (next: http://localhost:39676/tests/dromaeo/cssquery-dojo.html) 08:35:23 INFO - PROCESS | 22207 | RSS: Main: 281657344 08:35:23 INFO - PROCESS | 22207 | 08:35:23 INFO - PROCESS | 22207 | __start_tp_report 08:35:23 INFO - PROCESS | 22207 | _x_x_mozilla_page_load 08:35:23 INFO - PROCESS | 22207 | _x_x_mozilla_page_load_details 08:35:23 INFO - PROCESS | 22207 | |i|pagename|runs| 08:35:23 INFO - PROCESS | 22207 | |0;dojo.html;2647.5102106110367;2661.1085286429047;2688.4757472292904;2692.9461410771787;2697.716739742327;4779.856604301868;4841.394825646794;4845.345878306428;4895.755212239387;4895.951040489594;4815.157347464197;4877.341558889549;4878.292647566101;4897.240927656219;4951.257311403282;4442.11157768446;4472.508024117345;4526.660500462462;4534.501204867462;4650.465196502411;4539.137563862872;4549.31760235964;4590.150822097906;4615.307703844416;4638.9536104638855;4390.143921935224;4403.779811009436;4451.844185453526;4471.910561788779;4494.5730155635165;4428.202923473774;4430.468343798732;4437.378766972626;4537.4328208973875;4546.795394207235;4476.820927162909;4492.034212644265;4493.0339976905125;4503.48209955856;4548.158590660738;4709.929351059737;4773;4793.089313030513;4894.951050489521;4927.802887884481;5206.557442617382;5240.6069544784295;5243.030039442715;5260.552853007499;5265.894682106375;5267.841964741064;5269.578433725293;5285.286486324336;5310.36275646921;5310.495502927216;4726.527347265246;4832.057748739033;4860.125177468019;4890.926636100461;4912.852614421573;5366.195070739343;5372.059889519319;5375.6774593524515;5419.0245755764345;5434.809781657623;5157.561607263425;5200.24596433515;5206.531412172847;5208.8437346879655;5210.6613070150315;5102.795888164506;5156.535911767959;5192.27308176848;5204.1673332266655;5283.418823929364;5200.089984252816;5200.24596433515;5201.895962080737;5209.895802083937;5225.399079105876;5154.53609175176;5157.4584668610005;5162.354705661793;5174.24973378858;5206.97396513015;4246.702730808814;4291.334843099325;4294.184105020036;4331.371951067078;4361.6510679145595;3788.242351529705;3813.637704418076;3849.018500282466;3849.615038496128;3935.134270460494;4462.486814016364;4470.396496472935;4473.239549276631;4475.910481790346;4516.81932722694;5233.476652334736;5265.315508983807;5280.947190528045;5283.313169288045;5284.9471505284455;4303.117860838521;4399.472063352418;4451.221036318631;4452.398926144993;4495.280755079171;4681.531846815291;4719.882002949954;4720.457147428021;4722.645801564897;4767.713937163781;4959.057779022047;4966.416849915407;4971.552560269593;4976.576990955809;5021;5095;5112.693238405707;5169.974150129226;5180.352455943007;5273.6044796639635;4880.511948805233;4910.607151427806;4916.508349165055;4923.6307276955085;4957.578605818401;5129.281900533853;5131.076406246912;5133.127368347465;5135.589152867687;5139.357580302462;5124.154514505214;5138.203578445347;5194.013137503862;5195.246689230116;5271.604629652715;5070;5078.619103567174;5080.060188865072;5086.64393492452;5127.051495473349;5081.11080560893;5083.822066227664;5084.542391184811;5090.08378491875;5099.847004589868;4866.05112003156;4950.084234416644;5014.022265658307;5023.196288593807;5083.262926875656;5151.974240128776;5160.174372100596;5161.09680805865;5161.483851614808;5164.354455693038;4998.475160108136;5004.524570165829;5042.243663450512;5054.19132938728;5081.8475445736685 08:35:23 INFO - PROCESS | 22207 | |1;ext.html;558.7066789935284;566.275167785235;571.54276578737;576.8586696259417;577.4168090228869;30109.69890301096;37075;38266.23467530648;38355.616443835555;42372.152556948844;39457.21085578287;39849.40225896607;39894;39909.600903990955;39982.40026399606;7467.402607791377;7609.239076092402;7610.124835643889;7612.885806712904;7615.428842836782;7668.233176682315;7746.109197442282;7748.496347737408;7753.302202801747;7757.883631745528;7706.267904549087;7768.611569421535;7771.922280777205;7772.650230739602;7781.688732450723;7714.6142692865415;7728.497647652941;7730.574818384986;7737.187595302468;7759.37924966007;7649.770506884803;7725.922740772577;7727.459077864495;7728.265814747646;7728.845423091507;37863.81068094669;38125;38133;38190.236195276215;38206.42690359647;3097.5353696945413;3117.2986078132467;3177.1739347769517;3443.3974054540354;3753.5871054184017;29781.702182978326;29845.850770746223;30220.697793022227;32095.19762005945;33184.50223246653;3318.982231811708;3343.264481813997;3354.580677415323;3361.915952101217;3382.543356646846;253130;256057;256347.99999999814;256806;257083;55101.44898551043;56069.71965140148;56180.15729763975;56203.43796562064;56220.43779562234;33611.15972100717;34895.4765678515;59340.70329648324;59830.70084649636;59919;13243.271620060796;13342.13276137048;13348.93325533366;13361.398737056856;13363.33183340829;9931.10620044185;9981.650642227487;10037.598496060076;10046.24653151002;10052.045055719695;19328.806711932702;19357;19389.928115095987;19409.32067377635;19416.320428784926;7390.445716571278;7397.18630950595;7404.705999900042;7544.453387055641;7562.236729152889;780.9023872015998;833.5957060825494;883.5273128876021;953.5232383808096;959.5633986536109;27376.178714638594;27644.72355276462;28808.711912881023;30047.69952300449;31215;912.8813254276902;915.8809354783835;962.6486332488591;967.8886928003229;1037.3620223562605;14480.637984050272;14912;14990.775138372934;15209.391624335123;15213.163276019925;371256;372479;375588;375638;375678;47357;47732.76133619379;47778.761106194244;47829.521704783205;47834;1112.6272698645882;1117.8490903728054;1122.320995797547;1189.637160665988;1208.6313674329238;21496;30375.84812076014;30867.382652347278;30975.535366969063;31706.670799565713;45476.545234548554;46166.769166155296;46206.76896615495;46245.76877115593;46259.76870115628;336590;338923;340373;340849;341071;21298.25456109029;23021.88489057544;25432.872835635702;25600.487990240465;25954.09160679367;41000;41024.58975410327;41143;41273.380899287135;41405.79297103495;35002.29995400129;35242.823785881934;35299.82350088233;35556.82221588876;36110.819445902605;34765;34831.12922176966;35250.1187470305;35366.46950295696;35396.46905296474;34209.31581368409;34659.13352166216;34778.652213477544;34937.82531087328;35611.10972225715;29890.402191955603;32205.35589288248;32257.51613725843;32345.838270808494;32403.67596324101;24779.511533242705;24987;25146.24561263165;25203.621945670464;25596 08:35:23 INFO - PROCESS | 22207 | |2;jquery.html;344.96722811332916;359.70504186567024;364.3932851801749;365.8573156468977;379.41948818308;12733.936330318347;16125;16310.836891631096;16535.255913483892;17556.473305800813;15318.846811531881;15675.29461174247;15796.684066318667;15893.52319430416;15944.441944531944;4331.436913201295;4877.926831097537;4989.077020751154;5025.84922452327;5070.923936140961;3665.963340366602;3845.9230815383676;4961.3798275215595;5614.438556144394;5872.148538461921;5939.584229103964;5942.554308426886;5943.524518038546;5944.554158438113;5945.702714864261;5649.604527683064;5740.655560666352;5780.826575202751;5783.438471612641;5784.768609255667;4951.777170027357;5081.822136225214;5087.109755792721;5088.872778180538;5099.541041306263;20172.69740953887;20498.69251961207;20568.485787855425;20571.280005199747;20596.27913023037;1904.2192700992664;2003.6593779057596;2368.6447032945025;2493.7007559092845;2510.083819405922;9094.909050909473;9649.179819715333;12778.361081945959;13222;13770.380332884944;1646.3743777364646;1694.593297608565;1729.7232442809216;1731.5844197392662;1746.9301227950994;61665.38334616641;63986;64095.999999999534;72658.27341726568;73800;9992;10179.898201018043;10227.386356818615;10386.532606032746;10442.164626829835;14079.0848594841;14089.36597853099;14097.718045639234;14108.224047677271;14115.647108822362;6765.1205343305055;6786.626735529593;6877.449804015667;6989.0564773755905;6995.755148569776;6144.41628045335;6166.599171053867;6350.491960643138;6351.142595749515;6366.490680745529;4316.956830431655;4428.357888106271;4453.977730111394;4482.517688969373;4515.2324104902245;1691.9830801692071;1698.507432844486;1731.8874273172203;1807;1893.3751861885544;795.8806179073185;818.8607936650784;820.7373640435003;828.4201059258543;871.6861929705301;16354.836451635569;16612.169391530377;17206.33301838217;17601.383951561635;17628;876.6624849433014;882.1178821178821;884.6815146547237;888.7200531832452;910.1717437132178;9077.228435582918;9520.8571871422;9601.135897769094;9642.614295428244;9728;334218;338899;341762;359979;361178;69824;71563.6421817898;72586.27413725795;75352;75414;874.3660845886682;888.9599968001455;899.9626261367883;915.5971372596036;916.8258030974093;14811.481598144444;14949.252537373306;15936.282867271233;17088.145592720066;17418.129093545525;35073.82463087668;38248.61751382562;38950.4157437633;39900.8004959985;40952.38571421371;49324.50675493343;50863.49136508587;50984;52263.73868130635;52583.21125183202;7349.595772232578;7393.112826460859;7393.778186654409;7556.546607203585;7719.266669666373;8874.023857375554;11351.943240283746;11382.94308528452;11411.714707132056;11539.769204616028;10307.123894469054;10355.482225888525;10665.573377064831;10732.034116929513;11146.442677866236;9734.853977190489;10041.196704263788;10277.794444111225;10400.479976001321;10567.89432105669;10069.395836249849;10282.177425805769;10289.073983341535;10505.264631475724;10935.671929842118;6302.401271879165;6831.180258369028;6922.376986071277;7261.5280006799385;7333;9174.724758257264;10239.232057595562;10450.425226612306;10559.683209503728;10863.837042444527 08:35:23 INFO - PROCESS | 22207 | |3;mootools.html;1234.7160153164778;1330.9267990260535;1404.2487269310918;1436.755751522241;1682.2682133272028;6722.495812814034;7560.810979725509;7887.921120788797;7892.131865494791;7966.800829979239;7746.573938433384;7774.37804975602;7829.80425489363;7837.294643482085;7855.096663883655;2172.9239476618322;2182.2580322690283;2182.694422780812;2188.1684959715285;2191.5726433345503;2156.6764985252257;2201.1085510368325;2202.526456811785;2202.581509513195;2204.360735386736;2163.891805409731;2187.8030977212047;2191.594555007329;2192.375173075674;2201.856879302848;2157.9352619421443;2158.2985529702833;2167.8590891592075;2169.6745488176743;2175.0755928730227;2059.6498595238845;2118.8834614096218;2121.4272146520507;2124.3095993802076;2126.489642485808;7572.39420846331;7581.924180758177;7849.45053846231;7940.1662825403655;7974.3221826144845;4361;4503.887402814923;4524.638028957708;4567.200739870509;4569.246074397721;2874.4107457971068;2977.7766667500023;3041.1180757580273;3054.3433161870084;3055.3736484020947;949.3639261694681;961.053362437998;971.4754032822267;982.4940155819759;994.9005099490065;10676.786464270748;10842.945785271102;10881.401522916236;10921.399323037229;10955.4522273886;4252.340887162495;4368.191884501377;4381.058072514425;4399.20814253431;4432.4237849080055;9245.936717277466;9277.304202184863;9278.628854845865;9284.350095493252;9343.71968840936;4534.093181363674;4545.204589196877;4550.453945526492;4566.45202575693;4571.26859702446;3511.982440087834;3611.855525778992;3618.5838628558054;4066.044479547304;4112.568180341081;3642.6357364263363;3691.9815400922826;3747.3254814133174;3768.8680896169053;3783.981080094637;1192.469351138735;1196.8025275829564;1206.7707135644375;1230;1236.1717649174896;740.2782287269869;740.9222031686595;790.8734602463693;808.6401551309729;813.4062134641626;5025.974870125699;5131.1277082895995;5265.552428043583;5331.546818520392;5389.51494365509;839.8320335932716;841.5497708725802;853.88899443072;884.7699598104539;901.2429559170329;3441.7246620270316;3500.9124771880906;3529.2235708144167;3578.355895938704;3684.705223582107;9567.665131720356;9888.901110988798;9923.156531694887;9949.751256218653;9959.352642078242;9867;9869.950650246703;9896.752581185385;9909.554070066864;9910.851337229948;7101.254368291255;7245.311695388929;7278.672459739324;7279.963600181965;7281.126264848146;4988.12707776145;5008.647665130467;5175.792968281377;5328.987492376436;5449.548099541909;8707.172818582225;8870.467771933705;8895.066018068268;8940.195382415613;8945.865812012695;7018.613976231356;8692.565371731262;8874.51190184546;8924.107589241024;9182.403143795633;6610.074589557562;6829.2487826338065;6881.793546193622;6897.172339319314;6907.102076729993;7433.10802703679;7493.737719179802;7498.062742157231;7503.287187717158;7512.8873066905135;6855.383015528626;6881.208661004049;6922.584644921119;6981.232064472802;7223.855522889407;6883.793486195422;6934.16789985205;7003;7027.929720702932;7058.223595404604;6050.546209034252;6229.0967809668255;6286.591371560834;6298.748050077946;6310.242770867525;4570.268756998864;4651.953480465152;4754.263089221176;4754.524547545356;4803.03939212152;4509.819607215674;4735.526447355237;4759.405074365704;4786.497417771223;4819 08:35:23 INFO - PROCESS | 22207 | |4;prototype.html;298.39574860906663;304.70595874980654;308.0834517311001;308.3893890097606;309.1883805011844;4771.165046116928;4777.9522204777895;4779.283107533872;4791.784369703363;4807.399075115611;4738.123447162277;4748.881277968053;4752.07334569759;4756.143894099061;4761.119192949298;3604.639536046394;3683.121607979923;3685.5208822853124;3696.482492451059;3700.130469339703;3626.746127771044;3695.353313170198;3725.329440700673;3766.378547539666;3812.866549670762;3728.7949162796035;3739.981300093509;3744.6817020553285;3745.513083299167;3756.0985363512696;3614.0964758810296;3733.3653278942375;3740.532433445833;3745.700343972476;3753.493278407407;3118.8284644344553;3236.757243206769;3286.819224942651;3303.900882973515;3304.8512816923294;4590.655700822452;4638.791254393526;4639.188142075157;4641.419822522184;4641.605463535603;4255.8084886180195;4293.914121717548;4294.506131794852;4303.419038429804;4308.67684923632;4703.800530864608;4973.626977976666;4976.4277108132665;4976.726280054596;4979;3657.835397407123;3659.70722342212;3662.322470342995;3664.3770559005034;3666.1934374437847;5198.818041368534;5207.765650545734;5223.347081614798;5230.163173892197;5233.110371236823;3764.79293638847;3767.2088861339425;3767.3407153747985;3767.8869633910476;3772.9817744102443;3583.4445660922597;3768.6985041197186;3803.5245594300713;3819.961800382016;3821.3885778275344;4281.336392859112;4285.61429471349;4290.506591741927;4291.420658211102;4296.334068219431;4985.651004429655;4989.401271847401;4990.4011518618;4992.700437973734;5011.649184557046;1242.9254244745164;1298.4546490474024;1298.759684501318;1313.756954963335;1314.9480415667429;831.8211584509238;853.6938484119307;867.3538214030588;867.6659486097772;874.2612492443875;3915.941260881089;3928.823202955874;3942.1025546223505;3944.36890097583;3949.5458022327225;4529.660275479287;4535.387722657465;4538.909221815546;4543.227651299287;4544.977275113603;3841.500604921398;3925.450436938831;3942.7634341939574;3980.2238563480423;3987.182627561343;2457.299669594157;2460.2127319258025;2539.733328000533;2737.8083534152815;2761.6962134165224;4660.207764679944;4737.692050016738;4824.252240902666;4846.903061938741;4851.733154676526;5209.6874187548865;5212.4266330703595;5233.162693968947;5233.947660523346;5248.895022099537;4753.215719406259;4873.439554451284;4882.145624515767;4887.780049897692;4898.926516102332;5030;5105.897882042264;5115.5396014358885;5118.539331460186;5129.692218466755;5021.7740201690285;5028.698278103326;5031.698098114125;5038.614381045242;5040.319556859924;4660.021395506846;4856.271559266138;4874.58566021878;4877.878053048702;4878.512148785093;3635.4546817977516;3663.2856592964117;3673.7979411132646;3675.8713445029293;3677.558692956862;5195.922061169161;5199.896002080013;5200;5200.843974680765;5202.115640341075;4881;5026.888706743103;5034.194528875362;5036.420811606712;5058.342415485963;4995.575376093073;5033.615755667221;5041.596672266283;5041.798328066836;5050.015247026795;4970.229614409773;4973.179425394769;4973.602111831117;4983.825566105169;4984.576311013459;4865.635077369141;5060.343319757157;5064.822731204537;5072.264521644414;5075.28945947575;4928.383952005999;4944.208926571731;4956.281339205723;4968.403791545038;4973.204287314157 08:35:23 INFO - PROCESS | 22207 | |5;yui.html;649.3409189672482;666.7066490744076;682.8873235916076;686.8488932434868;733.9577799524675;11755.82441755824;12725;12726.554570590031;12736.108472406935;12741.299228542439;13294.601161965133;13310.401031953561;13324.533641322556;13333.266670333127;13335;620.9596376235553;747.7644541969289;756.4553521464537;765.4182821055982;769.6728890221661;769.2653515892338;770.8997830282084;771.3289438188783;773.6479901644739;774.0827119862952;823.6911158315631;824.6165533027141;825.0264687668549;825.0470706334194;825.0923983618002;653.5621133840339;671.2347923367316;672.0758956434902;673.4343151752552;820.958952052398;580.5906835680835;595.8272101090679;599.3886236039259;600.3396264109444;600.414595769126;12625.305608191546;12627.116101872873;12690.555830545887;12701.491940322376;12714.872851271553;12305.56930507428;12720.554780582728;12781.808272875915;12900.290484023375;13249.47002119914;11309.886901131047;11434.771304573862;11637.825432618518;11720.120990925629;11932.582359617458;4065.3698676705158;4070.816813243411;4134.855280065213;4223.429836972;4272.423222864935;65381.673091634715;66561;66638.3336166637;67817.66091169562;67871;9822.656207032862;9983.800323993624;10274;10547.525361358757;10666.573337066586;17500.912495437442;17701.645967080585;17743.11284435773;17744;17751;6503.9349606504275;6520.543561950618;6610.8016759497295;6698.062271282024;6886.896696549556;3632.328019316435;3657.104009517685;3742.3450896093077;3742.5696044954634;3782.451544526028;2838.2194896403244;2963.577482808264;2964.051503518853;2966.006387860048;2967.2433529449854;485.5605676862445;487.2082865343816;497.2417063977463;515.4253007896243;516;535.9356877174764;546.4289817141017;559.426587747562;564.9858753531195;573.2547688005576;6941.930580694128;7184.5940249907735;8651.6971905983;8717.869231961526;8757.912420875837;613.4999975020434;633.4583930739152;635.6027482823235;637.0317117980643;640.4748106552676;3901.6098390160755;3978.3634618461488;3988.7407318524783;4020.1758639478835;4093.6111069448357;80877.59561202273;100318;103286;104185;107625.4618726917;50505;55910;76971;86169.13830861611;86936;43036.56963430388;45113.548864510936;51411.48588514142;70235.64882175556;72636.46271835454;7729.729459468892;8249.29880960101;8253.174682531939;8335.49987000782;8410.537420441935;33980;44764.298681349006;45114.323285151404;45198.77400612976;45529;34812.477812833335;37021;40050.59949400469;40050.79974600108;40119.598804011584;10764.246502745045;10804.621838235624;10876.619318323821;11260.39667306454;11386;12092.879071209527;12627.93686031564;12878.291693956922;12994.350282486026;13202.273874936587;11217.214794964275;11359.658039978061;11570.768584628091;11884.168108232341;12255.080868934687;11069.114470842153;11150.776984460428;11456.140789440658;11631.709207269885;12006;10011.749706257402;10084.54619542137;10805.837912431163;11029.779404412027;11045.171612129283;9544.618215271312;9714.368566043184;9717.562709678223;9757.365771225132;10081.270024764615;7997.480163789335;9034;9366.391184572982;9506.873401534327;9742 08:35:23 INFO - PROCESS | 22207 | __end_tp_report 08:35:23 INFO - PROCESS | 22207 | __start_cc_report 08:35:23 INFO - PROCESS | 22207 | _x_x_mozilla_cycle_collect,1005 08:35:23 INFO - PROCESS | 22207 | __end_cc_report 08:35:23 INFO - PROCESS | 22207 | __startTimestamp1471361723633__endTimestamp 08:35:23 INFO - PROCESS | 22207 | 08:35:23 INFO - PROCESS | 22207 | ------- Summary: start ------- 08:35:23 INFO - PROCESS | 22207 | Number of tests: 6 08:35:23 INFO - PROCESS | 22207 | 08:35:23 INFO - PROCESS | 22207 | [#0] dojo.html Cycles:165 Average:4820.74 Median:4959.06 stddev:519.53 (10.5%) stddev-sans-first:492.36 08:35:23 INFO - PROCESS | 22207 | Values: 2647.5 2661.1 2688.5 2692.9 2697.7 4779.9 4841.4 4845.3 4895.8 4896.0 4815.2 4877.3 4878.3 4897.2 4951.3 4442.1 4472.5 4526.7 4534.5 4650.5 4539.1 4549.3 4590.2 4615.3 4639.0 4390.1 4403.8 4451.8 4471.9 4494.6 4428.2 4430.5 4437.4 4537.4 4546.8 4476.8 4492.0 4493.0 4503.5 4548.2 4709.9 4773.0 4793.1 4895.0 4927.8 5206.6 5240.6 5243.0 5260.6 5265.9 5267.8 5269.6 5285.3 5310.4 5310.5 4726.5 4832.1 4860.1 4890.9 4912.9 5366.2 5372.1 5375.7 5419.0 5434.8 5157.6 5200.2 5206.5 5208.8 5210.7 5102.8 5156.5 5192.3 5204.2 5283.4 5200.1 5200.2 5201.9 5209.9 5225.4 5154.5 5157.5 5162.4 5174.2 5207.0 4246.7 4291.3 4294.2 4331.4 4361.7 3788.2 3813.6 3849.0 3849.6 3935.1 4462.5 4470.4 4473.2 4475.9 4516.8 5233.5 5265.3 5280.9 5283.3 5284.9 4303.1 4399.5 4451.2 4452.4 4495.3 4681.5 4719.9 4720.5 4722.6 4767.7 4959.1 4966.4 4971.6 4976.6 5021.0 5095.0 5112.7 5170.0 5180.4 5273.6 4880.5 4910.6 4916.5 4923.6 4957.6 5129.3 5131.1 5133.1 5135.6 5139.4 5124.2 5138.2 5194.0 5195.2 5271.6 5070.0 5078.6 5080.1 5086.6 5127.1 5081.1 5083.8 5084.5 5090.1 5099.8 4866.1 4950.1 5014.0 5023.2 5083.3 5152.0 5160.2 5161.1 5161.5 5164.4 4998.5 5004.5 5042.2 5054.2 5081.8 08:35:23 INFO - PROCESS | 22207 | 08:35:23 INFO - PROCESS | 22207 | [#1] ext.html Cycles:180 Average:47633.57 Median:36592.91 stddev:86071.11 (235.2%) stddev-sans-first:86239.99 08:35:23 INFO - PROCESS | 22207 | Values: 558.7 566.3 571.5 576.9 577.4 30109.7 37075.0 38266.2 38355.6 42372.2 39457.2 39849.4 39894.0 39909.6 39982.4 7467.4 7609.2 7610.1 7612.9 7615.4 7668.2 7746.1 7748.5 7753.3 7757.9 7706.3 7768.6 7771.9 7772.7 7781.7 7714.6 7728.5 7730.6 7737.2 7759.4 7649.8 7725.9 7727.5 7728.3 7728.8 37863.8 38125.0 38133.0 38190.2 38206.4 3097.5 3117.3 3177.2 3443.4 3753.6 29781.7 29845.9 30220.7 32095.2 33184.5 3319.0 3343.3 3354.6 3361.9 3382.5 253130.0 256057.0 256348.0 256806.0 257083.0 55101.4 56069.7 56180.2 56203.4 56220.4 33611.2 34895.5 59340.7 59830.7 59919.0 13243.3 13342.1 13348.9 13361.4 13363.3 9931.1 9981.7 10037.6 10046.2 10052.0 19328.8 19357.0 19389.9 19409.3 19416.3 7390.4 7397.2 7404.7 7544.5 7562.2 780.9 833.6 883.5 953.5 959.6 27376.2 27644.7 28808.7 30047.7 31215.0 912.9 915.9 962.6 967.9 1037.4 14480.6 14912.0 14990.8 15209.4 15213.2 371256.0 372479.0 375588.0 375638.0 375678.0 47357.0 47732.8 47778.8 47829.5 47834.0 1112.6 1117.8 1122.3 1189.6 1208.6 21496.0 30375.8 30867.4 30975.5 31706.7 45476.5 46166.8 46206.8 46245.8 46259.8 336590.0 338923.0 340373.0 340849.0 341071.0 21298.3 23021.9 25432.9 25600.5 25954.1 41000.0 41024.6 41143.0 41273.4 41405.8 35002.3 35242.8 35299.8 35556.8 36110.8 34765.0 34831.1 35250.1 35366.5 35396.5 34209.3 34659.1 34778.7 34937.8 35611.1 29890.4 32205.4 32257.5 32345.8 32403.7 24779.5 24987.0 25146.2 25203.6 25596.0 08:35:23 INFO - PROCESS | 22207 | 08:35:23 INFO - PROCESS | 22207 | [#2] jquery.html Cycles:180 Average:22986.69 Median:22634.67 stddev:57550.37 (254.3%) stddev-sans-first:57686.70 08:35:23 INFO - PROCESS | 22207 | Values: 345.0 359.7 364.4 365.9 379.4 12733.9 16125.0 16310.8 16535.3 17556.5 15318.8 15675.3 15796.7 15893.5 15944.4 4331.4 4877.9 4989.1 5025.8 5070.9 3666.0 3845.9 4961.4 5614.4 5872.1 5939.6 5942.6 5943.5 5944.6 5945.7 5649.6 5740.7 5780.8 5783.4 5784.8 4951.8 5081.8 5087.1 5088.9 5099.5 20172.7 20498.7 20568.5 20571.3 20596.3 1904.2 2003.7 2368.6 2493.7 2510.1 9094.9 9649.2 12778.4 13222.0 13770.4 1646.4 1694.6 1729.7 1731.6 1746.9 61665.4 63986.0 64096.0 72658.3 73800.0 9992.0 10179.9 10227.4 10386.5 10442.2 14079.1 14089.4 14097.7 14108.2 14115.6 6765.1 6786.6 6877.4 6989.1 6995.8 6144.4 6166.6 6350.5 6351.1 6366.5 4317.0 4428.4 4454.0 4482.5 4515.2 1692.0 1698.5 1731.9 1807.0 1893.4 795.9 818.9 820.7 828.4 871.7 16354.8 16612.2 17206.3 17601.4 17628.0 876.7 882.1 884.7 888.7 910.2 9077.2 9520.9 9601.1 9642.6 9728.0 334218.0 338899.0 341762.0 359979.0 361178.0 69824.0 71563.6 72586.3 75352.0 75414.0 874.4 889.0 900.0 915.6 916.8 14811.5 14949.3 15936.3 17088.1 17418.1 35073.8 38248.6 38950.4 39900.8 40952.4 49324.5 50863.5 50984.0 52263.7 52583.2 7349.6 7393.1 7393.8 7556.5 7719.3 8874.0 11351.9 11382.9 11411.7 11539.8 10307.1 10355.5 10665.6 10732.0 11146.4 9734.9 10041.2 10277.8 10400.5 10567.9 10069.4 10282.2 10289.1 10505.3 10935.7 6302.4 6831.2 6922.4 7261.5 7333.0 9174.7 10239.2 10450.4 10559.7 10863.8 08:35:23 INFO - PROCESS | 22207 | 08:35:23 INFO - PROCESS | 22207 | [#3] mootools.html Cycles:180 Average:5157.11 Median:5297.27 stddev:2909.01 (54.9%) stddev-sans-first:2902.24 08:35:23 INFO - PROCESS | 22207 | Values: 1234.7 1330.9 1404.2 1436.8 1682.3 6722.5 7560.8 7887.9 7892.1 7966.8 7746.6 7774.4 7829.8 7837.3 7855.1 2172.9 2182.3 2182.7 2188.2 2191.6 2156.7 2201.1 2202.5 2202.6 2204.4 2163.9 2187.8 2191.6 2192.4 2201.9 2157.9 2158.3 2167.9 2169.7 2175.1 2059.6 2118.9 2121.4 2124.3 2126.5 7572.4 7581.9 7849.5 7940.2 7974.3 4361.0 4503.9 4524.6 4567.2 4569.2 2874.4 2977.8 3041.1 3054.3 3055.4 949.4 961.1 971.5 982.5 994.9 10676.8 10842.9 10881.4 10921.4 10955.5 4252.3 4368.2 4381.1 4399.2 4432.4 9245.9 9277.3 9278.6 9284.4 9343.7 4534.1 4545.2 4550.5 4566.5 4571.3 3512.0 3611.9 3618.6 4066.0 4112.6 3642.6 3692.0 3747.3 3768.9 3784.0 1192.5 1196.8 1206.8 1230.0 1236.2 740.3 740.9 790.9 808.6 813.4 5026.0 5131.1 5265.6 5331.5 5389.5 839.8 841.5 853.9 884.8 901.2 3441.7 3500.9 3529.2 3578.4 3684.7 9567.7 9888.9 9923.2 9949.8 9959.4 9867.0 9870.0 9896.8 9909.6 9910.9 7101.3 7245.3 7278.7 7280.0 7281.1 4988.1 5008.6 5175.8 5329.0 5449.5 8707.2 8870.5 8895.1 8940.2 8945.9 7018.6 8692.6 8874.5 8924.1 9182.4 6610.1 6829.2 6881.8 6897.2 6907.1 7433.1 7493.7 7498.1 7503.3 7512.9 6855.4 6881.2 6922.6 6981.2 7223.9 6883.8 6934.2 7003.0 7027.9 7058.2 6050.5 6229.1 6286.6 6298.7 6310.2 4570.3 4652.0 4754.3 4754.5 4803.0 4509.8 4735.5 4759.4 4786.5 4819.0 08:35:23 INFO - PROCESS | 22207 | 08:35:23 INFO - PROCESS | 22207 | [#4] prototype.html Cycles:180 Average:4120.49 Median:4660.11 stddev:1196.41 (25.7%) stddev-sans-first:1164.87 08:35:23 INFO - PROCESS | 22207 | Values: 298.4 304.7 308.1 308.4 309.2 4771.2 4778.0 4779.3 4791.8 4807.4 4738.1 4748.9 4752.1 4756.1 4761.1 3604.6 3683.1 3685.5 3696.5 3700.1 3626.7 3695.4 3725.3 3766.4 3812.9 3728.8 3740.0 3744.7 3745.5 3756.1 3614.1 3733.4 3740.5 3745.7 3753.5 3118.8 3236.8 3286.8 3303.9 3304.9 4590.7 4638.8 4639.2 4641.4 4641.6 4255.8 4293.9 4294.5 4303.4 4308.7 4703.8 4973.6 4976.4 4976.7 4979.0 3657.8 3659.7 3662.3 3664.4 3666.2 5198.8 5207.8 5223.3 5230.2 5233.1 3764.8 3767.2 3767.3 3767.9 3773.0 3583.4 3768.7 3803.5 3820.0 3821.4 4281.3 4285.6 4290.5 4291.4 4296.3 4985.7 4989.4 4990.4 4992.7 5011.6 1242.9 1298.5 1298.8 1313.8 1314.9 831.8 853.7 867.4 867.7 874.3 3915.9 3928.8 3942.1 3944.4 3949.5 4529.7 4535.4 4538.9 4543.2 4545.0 3841.5 3925.5 3942.8 3980.2 3987.2 2457.3 2460.2 2539.7 2737.8 2761.7 4660.2 4737.7 4824.3 4846.9 4851.7 5209.7 5212.4 5233.2 5233.9 5248.9 4753.2 4873.4 4882.1 4887.8 4898.9 5030.0 5105.9 5115.5 5118.5 5129.7 5021.8 5028.7 5031.7 5038.6 5040.3 4660.0 4856.3 4874.6 4877.9 4878.5 3635.5 3663.3 3673.8 3675.9 3677.6 5195.9 5199.9 5200.0 5200.8 5202.1 4881.0 5026.9 5034.2 5036.4 5058.3 4995.6 5033.6 5041.6 5041.8 5050.0 4970.2 4973.2 4973.6 4983.8 4984.6 4865.6 5060.3 5064.8 5072.3 5075.3 4928.4 4944.2 4956.3 4968.4 4973.2 08:35:23 INFO - PROCESS | 22207 | 08:35:23 INFO - PROCESS | 22207 | [#5] yui.html Cycles:180 Average:16282.53 Median:44938.92 stddev:23138.48 (51.5%) stddev-sans-first:23173.61 08:35:23 INFO - PROCESS | 22207 | Values: 649.3 666.7 682.9 686.8 734.0 11755.8 12725.0 12726.6 12736.1 12741.3 13294.6 13310.4 13324.5 13333.3 13335.0 621.0 747.8 756.5 765.4 769.7 769.3 770.9 771.3 773.6 774.1 823.7 824.6 825.0 825.0 825.1 653.6 671.2 672.1 673.4 821.0 580.6 595.8 599.4 600.3 600.4 12625.3 12627.1 12690.6 12701.5 12714.9 12305.6 12720.6 12781.8 12900.3 13249.5 11309.9 11434.8 11637.8 11720.1 11932.6 4065.4 4070.8 4134.9 4223.4 4272.4 65381.7 66561.0 66638.3 67817.7 67871.0 9822.7 9983.8 10274.0 10547.5 10666.6 17500.9 17701.6 17743.1 17744.0 17751.0 6503.9 6520.5 6610.8 6698.1 6886.9 3632.3 3657.1 3742.3 3742.6 3782.5 2838.2 2963.6 2964.1 2966.0 2967.2 485.6 487.2 497.2 515.4 516.0 535.9 546.4 559.4 565.0 573.3 6941.9 7184.6 8651.7 8717.9 8757.9 613.5 633.5 635.6 637.0 640.5 3901.6 3978.4 3988.7 4020.2 4093.6 80877.6 100318.0 103286.0 104185.0 107625.5 50505.0 55910.0 76971.0 86169.1 86936.0 43036.6 45113.5 51411.5 70235.6 72636.5 7729.7 8249.3 8253.2 8335.5 8410.5 33980.0 44764.3 45114.3 45198.8 45529.0 34812.5 37021.0 40050.6 40050.8 40119.6 10764.2 10804.6 10876.6 11260.4 11386.0 12092.9 12627.9 12878.3 12994.4 13202.3 11217.2 11359.7 11570.8 11884.2 12255.1 11069.1 11150.8 11456.1 11631.7 12006.0 10011.7 10084.5 10805.8 11029.8 11045.2 9544.6 9714.4 9717.6 9757.4 10081.3 7997.5 9034.0 9366.4 9506.9 9742.0 08:35:23 INFO - PROCESS | 22207 | -------- Summary: end -------- 08:35:23 INFO - PROCESS | 22207 | 08:35:24 INFO - TEST-INFO | 22207: exit 0 08:35:24 INFO - TEST-OK | dromaeo_css | took 1119872ms 08:35:24 INFO - TEST-START | kraken 08:35:24 INFO - operating with platform_type : linux_ 08:35:24 INFO - Initialising browser for kraken test... 08:35:24 INFO - TEST-INFO | started process 22510 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjlI1mq/profile http://localhost:39676/getInfo.html) 08:35:28 INFO - PROCESS | 22510 | __metrics Screen width/height:1600/1200 08:35:28 INFO - PROCESS | 22510 | colorDepth:24 08:35:28 INFO - PROCESS | 22510 | Browser inner width/height: 1024/697 08:35:28 INFO - PROCESS | 22510 | __metrics 08:35:28 INFO - PROCESS | 22510 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:35:28 INFO - PROCESS | 22510 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:35:29 INFO - PROCESS | 22510 | console.error: PushService: 08:35:29 INFO - PROCESS | 22510 | stateChangeProcessEnqueue: Error transitioning state 08:35:29 INFO - PROCESS | 22510 | UnknownError 08:35:29 INFO - TEST-INFO | 22510: exit 0 08:35:29 INFO - Browser initialized. 08:35:29 INFO - Running cycle 1/1 for kraken test... 08:35:29 INFO - TEST-INFO | started process 22590 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjlI1mq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:35:41 INFO - PROCESS | 22590 | RSS: Main: 157253632 08:35:41 INFO - PROCESS | 22590 | 08:35:44 INFO - PROCESS | 22590 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39676/tests/kraken/driver.html?testName=audio-beat-detection) 08:35:45 INFO - PROCESS | 22590 | RSS: Main: 204603392 08:35:45 INFO - PROCESS | 22590 | 08:35:48 INFO - PROCESS | 22590 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39676/tests/kraken/driver.html?testName=audio-dft) 08:35:48 INFO - PROCESS | 22590 | RSS: Main: 196255744 08:35:48 INFO - PROCESS | 22590 | 08:35:52 INFO - PROCESS | 22590 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39676/tests/kraken/driver.html?testName=audio-fft) 08:35:52 INFO - PROCESS | 22590 | RSS: Main: 277991424 08:35:52 INFO - PROCESS | 22590 | 08:35:54 INFO - PROCESS | 22590 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39676/tests/kraken/driver.html?testName=audio-oscillator) 08:35:55 INFO - PROCESS | 22590 | RSS: Main: 188792832 08:35:55 INFO - PROCESS | 22590 | 08:35:57 INFO - PROCESS | 22590 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39676/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:35:58 INFO - PROCESS | 22590 | RSS: Main: 192425984 08:35:58 INFO - PROCESS | 22590 | 08:36:01 INFO - PROCESS | 22590 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39676/tests/kraken/driver.html?testName=imaging-darkroom) 08:36:02 INFO - PROCESS | 22590 | RSS: Main: 228966400 08:36:02 INFO - PROCESS | 22590 | 08:36:05 INFO - PROCESS | 22590 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39676/tests/kraken/driver.html?testName=imaging-desaturate) 08:36:06 INFO - PROCESS | 22590 | RSS: Main: 227713024 08:36:06 INFO - PROCESS | 22590 | 08:36:09 INFO - PROCESS | 22590 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39676/tests/kraken/driver.html?testName=json-parse-financial) 08:36:09 INFO - PROCESS | 22590 | RSS: Main: 227606528 08:36:09 INFO - PROCESS | 22590 | 08:36:11 INFO - PROCESS | 22590 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39676/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:36:12 INFO - PROCESS | 22590 | RSS: Main: 190410752 08:36:12 INFO - PROCESS | 22590 | 08:36:14 INFO - PROCESS | 22590 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39676/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:36:14 INFO - PROCESS | 22590 | RSS: Main: 198094848 08:36:14 INFO - PROCESS | 22590 | 08:36:16 INFO - PROCESS | 22590 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39676/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:36:17 INFO - PROCESS | 22590 | RSS: Main: 194981888 08:36:17 INFO - PROCESS | 22590 | 08:36:20 INFO - PROCESS | 22590 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39676/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:36:21 INFO - PROCESS | 22590 | RSS: Main: 190042112 08:36:21 INFO - PROCESS | 22590 | 08:36:23 INFO - PROCESS | 22590 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39676/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:36:24 INFO - PROCESS | 22590 | RSS: Main: 193581056 08:36:24 INFO - PROCESS | 22590 | 08:36:26 INFO - PROCESS | 22590 | Cycle 1(1): loaded http://localhost:39676/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39676/tests/kraken/driver.html?testName=ai-astar) 08:36:26 INFO - PROCESS | 22590 | RSS: Main: 243666944 08:36:26 INFO - PROCESS | 22590 | 08:36:26 INFO - PROCESS | 22590 | __start_tp_report 08:36:26 INFO - PROCESS | 22590 | _x_x_mozilla_page_load 08:36:26 INFO - PROCESS | 22590 | _x_x_mozilla_page_load_details 08:36:26 INFO - PROCESS | 22590 | |i|pagename|runs| 08:36:26 INFO - PROCESS | 22590 | |0;ai-astar;105;115;115;114;111;114;114;114;114;114 08:36:26 INFO - PROCESS | 22590 | |1;audio-beat-detection;144;128;126;178;122;126;145;121;180;121 08:36:26 INFO - PROCESS | 22590 | |2;audio-dft;160;160;160;162;161;162;161;160;161;162 08:36:26 INFO - PROCESS | 22590 | |3;audio-fft;76;77;76;110;77;77;75;77;125;76 08:36:26 INFO - PROCESS | 22590 | |4;audio-oscillator;86;87;127;86;87;86;128;86;86;132 08:36:26 INFO - PROCESS | 22590 | |5;imaging-gaussian-blur;116;116;117;116;117;117;117;117;117;118 08:36:26 INFO - PROCESS | 22590 | |6;imaging-darkroom;146;146;145;145;146;145;145;146;146;147 08:36:26 INFO - PROCESS | 22590 | |7;imaging-desaturate;95;95;95;95;94;95;95;96;94;95 08:36:26 INFO - PROCESS | 22590 | |8;json-parse-financial;67;65;66;65;65;69;66;66;67;65 08:36:26 INFO - PROCESS | 22590 | |9;json-stringify-tinderbox;66;65;66;66;66;65;66;66;66;66 08:36:26 INFO - PROCESS | 22590 | |10;stanford-crypto-aes;90;81;82;82;81;90;84;82;93;82 08:36:26 INFO - PROCESS | 22590 | |11;stanford-crypto-ccm;131;132;133;131;130;131;133;135;148;129 08:36:26 INFO - PROCESS | 22590 | |12;stanford-crypto-pbkdf2;173;170;169;171;168;170;169;170;170;176 08:36:26 INFO - PROCESS | 22590 | |13;stanford-crypto-sha256-iterative;70;68;68;70;67;67;67;67;67;72 08:36:26 INFO - PROCESS | 22590 | __end_tp_report 08:36:26 INFO - PROCESS | 22590 | __start_cc_report 08:36:26 INFO - PROCESS | 22590 | _x_x_mozilla_cycle_collect,1943 08:36:26 INFO - PROCESS | 22590 | __end_cc_report 08:36:26 INFO - PROCESS | 22590 | __startTimestamp1471361786593__endTimestamp 08:36:26 INFO - PROCESS | 22590 | 08:36:26 INFO - PROCESS | 22590 | ------- Summary: start ------- 08:36:26 INFO - PROCESS | 22590 | Number of tests: 14 08:36:26 INFO - PROCESS | 22590 | 08:36:26 INFO - PROCESS | 22590 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.00 stddev:3.02 (2.6%) stddev-sans-first:1.17 08:36:26 INFO - PROCESS | 22590 | Values: 105.0 115.0 115.0 114.0 111.0 114.0 114.0 114.0 114.0 114.0 08:36:26 INFO - PROCESS | 22590 | 08:36:26 INFO - PROCESS | 22590 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:136.00 stddev:22.75 (16.7%) stddev-sans-first:24.06 08:36:26 INFO - PROCESS | 22590 | Values: 144.0 128.0 126.0 178.0 122.0 126.0 145.0 121.0 180.0 121.0 08:36:26 INFO - PROCESS | 22590 | 08:36:26 INFO - PROCESS | 22590 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.87 08:36:26 INFO - PROCESS | 22590 | Values: 160.0 160.0 160.0 162.0 161.0 162.0 161.0 160.0 161.0 162.0 08:36:26 INFO - PROCESS | 22590 | 08:36:26 INFO - PROCESS | 22590 | [#3] audio-fft Cycles:10 Average:84.60 Median:76.50 stddev:17.71 (23.1%) stddev-sans-first:18.51 08:36:26 INFO - PROCESS | 22590 | Values: 76.0 77.0 76.0 110.0 77.0 77.0 75.0 77.0 125.0 76.0 08:36:26 INFO - PROCESS | 22590 | 08:36:26 INFO - PROCESS | 22590 | [#4] audio-oscillator Cycles:10 Average:99.10 Median:86.00 stddev:20.67 (24.0%) stddev-sans-first:21.38 08:36:26 INFO - PROCESS | 22590 | Values: 86.0 87.0 127.0 86.0 87.0 86.0 128.0 86.0 86.0 132.0 08:36:26 INFO - PROCESS | 22590 | 08:36:26 INFO - PROCESS | 22590 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 08:36:26 INFO - PROCESS | 22590 | Values: 116.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 118.0 08:36:26 INFO - PROCESS | 22590 | 08:36:26 INFO - PROCESS | 22590 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 08:36:26 INFO - PROCESS | 22590 | Values: 146.0 146.0 145.0 145.0 146.0 145.0 145.0 146.0 146.0 147.0 08:36:26 INFO - PROCESS | 22590 | 08:36:26 INFO - PROCESS | 22590 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 08:36:26 INFO - PROCESS | 22590 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 96.0 94.0 95.0 08:36:26 INFO - PROCESS | 22590 | 08:36:26 INFO - PROCESS | 22590 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:66.00 stddev:1.29 (1.9%) stddev-sans-first:1.32 08:36:26 INFO - PROCESS | 22590 | Values: 67.0 65.0 66.0 65.0 65.0 69.0 66.0 66.0 67.0 65.0 08:36:26 INFO - PROCESS | 22590 | 08:36:26 INFO - PROCESS | 22590 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:0.42 (0.6%) stddev-sans-first:0.44 08:36:26 INFO - PROCESS | 22590 | Values: 66.0 65.0 66.0 66.0 66.0 65.0 66.0 66.0 66.0 66.0 08:36:26 INFO - PROCESS | 22590 | 08:36:26 INFO - PROCESS | 22590 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:83.00 stddev:4.50 (5.4%) stddev-sans-first:4.34 08:36:26 INFO - PROCESS | 22590 | Values: 90.0 81.0 82.0 82.0 81.0 90.0 84.0 82.0 93.0 82.0 08:36:26 INFO - PROCESS | 22590 | 08:36:26 INFO - PROCESS | 22590 | [#11] stanford-crypto-ccm Cycles:10 Average:133.30 Median:132.50 stddev:5.44 (4.1%) stddev-sans-first:5.70 08:36:26 INFO - PROCESS | 22590 | Values: 131.0 132.0 133.0 131.0 130.0 131.0 133.0 135.0 148.0 129.0 08:36:26 INFO - PROCESS | 22590 | 08:36:26 INFO - PROCESS | 22590 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.60 Median:170.00 stddev:2.32 (1.4%) stddev-sans-first:2.29 08:36:26 INFO - PROCESS | 22590 | Values: 173.0 170.0 169.0 171.0 168.0 170.0 169.0 170.0 170.0 176.0 08:36:26 INFO - PROCESS | 22590 | 08:36:26 INFO - PROCESS | 22590 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:1.77 (2.6%) stddev-sans-first:1.76 08:36:26 INFO - PROCESS | 22590 | Values: 70.0 68.0 68.0 70.0 67.0 67.0 67.0 67.0 67.0 72.0 08:36:26 INFO - PROCESS | 22590 | -------- Summary: end -------- 08:36:26 INFO - PROCESS | 22590 | 08:36:27 INFO - TEST-INFO | 22590: exit 0 08:36:27 INFO - TEST-OK | kraken | took 63227ms 08:36:27 INFO - SUITE-END | took 1183s 08:36:27 INFO - Completed test suite (00:19:43) 08:36:27 INFO - javascript benchmark 08:36:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2647.5102106110367, 2661.1085286429047, 2688.4757472292904, 2692.9461410771787, 2697.716739742327, 4779.856604301868, 4841.394825646794, 4845.345878306428, 4895.755212239387, 4895.951040489594, 4815.157347464197, 4877.341558889549, 4878.292647566101, 4897.240927656219, 4951.257311403282, 4442.11157768446, 4472.508024117345, 4526.660500462462, 4534.501204867462, 4650.465196502411, 4539.137563862872, 4549.31760235964, 4590.150822097906, 4615.307703844416, 4638.9536104638855, 4390.143921935224, 4403.779811009436, 4451.844185453526, 4471.910561788779, 4494.5730155635165, 4428.202923473774, 4430.468343798732, 4437.378766972626, 4537.4328208973875, 4546.795394207235, 4476.820927162909, 4492.034212644265, 4493.0339976905125, 4503.48209955856, 4548.158590660738, 4709.929351059737, 4773.0, 4793.089313030513, 4894.951050489521, 4927.802887884481, 5206.557442617382, 5240.6069544784295, 5243.030039442715, 5260.552853007499, 5265.894682106375, 5267.841964741064, 5269.578433725293, 5285.286486324336, 5310.36275646921, 5310.495502927216, 4726.527347265246, 4832.057748739033, 4860.125177468019, 4890.926636100461, 4912.852614421573, 5366.195070739343, 5372.059889519319, 5375.6774593524515, 5419.0245755764345, 5434.809781657623, 5157.561607263425, 5200.24596433515, 5206.531412172847, 5208.8437346879655, 5210.6613070150315, 5102.795888164506, 5156.535911767959, 5192.27308176848, 5204.1673332266655, 5283.418823929364, 5200.089984252816, 5200.24596433515, 5201.895962080737, 5209.895802083937, 5225.399079105876, 5154.53609175176, 5157.4584668610005, 5162.354705661793, 5174.24973378858, 5206.97396513015, 4246.702730808814, 4291.334843099325, 4294.184105020036, 4331.371951067078, 4361.6510679145595, 3788.242351529705, 3813.637704418076, 3849.018500282466, 3849.615038496128, 3935.134270460494, 4462.486814016364, 4470.396496472935, 4473.239549276631, 4475.910481790346, 4516.81932722694, 5233.476652334736, 5265.315508983807, 5280.947190528045, 5283.313169288045, 5284.9471505284455, 4303.117860838521, 4399.472063352418, 4451.221036318631, 4452.398926144993, 4495.280755079171, 4681.531846815291, 4719.882002949954, 4720.457147428021, 4722.645801564897, 4767.713937163781, 4959.057779022047, 4966.416849915407, 4971.552560269593, 4976.576990955809, 5021.0, 5095.0, 5112.693238405707, 5169.974150129226, 5180.352455943007, 5273.6044796639635, 4880.511948805233, 4910.607151427806, 4916.508349165055, 4923.6307276955085, 4957.578605818401, 5129.281900533853, 5131.076406246912, 5133.127368347465, 5135.589152867687, 5139.357580302462, 5124.154514505214, 5138.203578445347, 5194.013137503862, 5195.246689230116, 5271.604629652715, 5070.0, 5078.619103567174, 5080.060188865072, 5086.64393492452, 5127.051495473349, 5081.11080560893, 5083.822066227664, 5084.542391184811, 5090.08378491875, 5099.847004589868, 4866.05112003156, 4950.084234416644, 5014.022265658307, 5023.196288593807, 5083.262926875656, 5151.974240128776, 5160.174372100596, 5161.09680805865, 5161.483851614808, 5164.354455693038, 4998.475160108136, 5004.524570165829, 5042.243663450512, 5054.19132938728, 5081.8475445736685], "value": 4786.4062073667355, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [558.7066789935284, 566.275167785235, 571.54276578737, 576.8586696259417, 577.4168090228869, 30109.69890301096, 37075.0, 38266.23467530648, 38355.616443835555, 42372.152556948844, 39457.21085578287, 39849.40225896607, 39894.0, 39909.600903990955, 39982.40026399606, 7467.402607791377, 7609.239076092402, 7610.124835643889, 7612.885806712904, 7615.428842836782, 7668.233176682315, 7746.109197442282, 7748.496347737408, 7753.302202801747, 7757.883631745528, 7706.267904549087, 7768.611569421535, 7771.922280777205, 7772.650230739602, 7781.688732450723, 7714.6142692865415, 7728.497647652941, 7730.574818384986, 7737.187595302468, 7759.37924966007, 7649.770506884803, 7725.922740772577, 7727.459077864495, 7728.265814747646, 7728.845423091507, 37863.81068094669, 38125.0, 38133.0, 38190.236195276215, 38206.42690359647, 3097.5353696945413, 3117.2986078132467, 3177.1739347769517, 3443.3974054540354, 3753.5871054184017, 29781.702182978326, 29845.850770746223, 30220.697793022227, 32095.19762005945, 33184.50223246653, 3318.982231811708, 3343.264481813997, 3354.580677415323, 3361.915952101217, 3382.543356646846, 253130.0, 256057.0, 256347.99999999814, 256806.0, 257083.0, 55101.44898551043, 56069.71965140148, 56180.15729763975, 56203.43796562064, 56220.43779562234, 33611.15972100717, 34895.4765678515, 59340.70329648324, 59830.70084649636, 59919.0, 13243.271620060796, 13342.13276137048, 13348.93325533366, 13361.398737056856, 13363.33183340829, 9931.10620044185, 9981.650642227487, 10037.598496060076, 10046.24653151002, 10052.045055719695, 19328.806711932702, 19357.0, 19389.928115095987, 19409.32067377635, 19416.320428784926, 7390.445716571278, 7397.18630950595, 7404.705999900042, 7544.453387055641, 7562.236729152889, 780.9023872015998, 833.5957060825494, 883.5273128876021, 953.5232383808096, 959.5633986536109, 27376.178714638594, 27644.72355276462, 28808.711912881023, 30047.69952300449, 31215.0, 912.8813254276902, 915.8809354783835, 962.6486332488591, 967.8886928003229, 1037.3620223562605, 14480.637984050272, 14912.0, 14990.775138372934, 15209.391624335123, 15213.163276019925, 371256.0, 372479.0, 375588.0, 375638.0, 375678.0, 47357.0, 47732.76133619379, 47778.761106194244, 47829.521704783205, 47834.0, 1112.6272698645882, 1117.8490903728054, 1122.320995797547, 1189.637160665988, 1208.6313674329238, 21496.0, 30375.84812076014, 30867.382652347278, 30975.535366969063, 31706.670799565713, 45476.545234548554, 46166.769166155296, 46206.76896615495, 46245.76877115593, 46259.76870115628, 336590.0, 338923.0, 340373.0, 340849.0, 341071.0, 21298.25456109029, 23021.88489057544, 25432.872835635702, 25600.487990240465, 25954.09160679367, 41000.0, 41024.58975410327, 41143.0, 41273.380899287135, 41405.79297103495, 35002.29995400129, 35242.823785881934, 35299.82350088233, 35556.82221588876, 36110.819445902605, 34765.0, 34831.12922176966, 35250.1187470305, 35366.46950295696, 35396.46905296474, 34209.31581368409, 34659.13352166216, 34778.652213477544, 34937.82531087328, 35611.10972225715, 29890.402191955603, 32205.35589288248, 32257.51613725843, 32345.838270808494, 32403.67596324101, 24779.511533242705, 24987.0, 25146.24561263165, 25203.621945670464, 25596.0], "value": 17437.231440077867, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.96722811332916, 359.70504186567024, 364.3932851801749, 365.8573156468977, 379.41948818308, 12733.936330318347, 16125.0, 16310.836891631096, 16535.255913483892, 17556.473305800813, 15318.846811531881, 15675.29461174247, 15796.684066318667, 15893.52319430416, 15944.441944531944, 4331.436913201295, 4877.926831097537, 4989.077020751154, 5025.84922452327, 5070.923936140961, 3665.963340366602, 3845.9230815383676, 4961.3798275215595, 5614.438556144394, 5872.148538461921, 5939.584229103964, 5942.554308426886, 5943.524518038546, 5944.554158438113, 5945.702714864261, 5649.604527683064, 5740.655560666352, 5780.826575202751, 5783.438471612641, 5784.768609255667, 4951.777170027357, 5081.822136225214, 5087.109755792721, 5088.872778180538, 5099.541041306263, 20172.69740953887, 20498.69251961207, 20568.485787855425, 20571.280005199747, 20596.27913023037, 1904.2192700992664, 2003.6593779057596, 2368.6447032945025, 2493.7007559092845, 2510.083819405922, 9094.909050909473, 9649.179819715333, 12778.361081945959, 13222.0, 13770.380332884944, 1646.3743777364646, 1694.593297608565, 1729.7232442809216, 1731.5844197392662, 1746.9301227950994, 61665.38334616641, 63986.0, 64095.999999999534, 72658.27341726568, 73800.0, 9992.0, 10179.898201018043, 10227.386356818615, 10386.532606032746, 10442.164626829835, 14079.0848594841, 14089.36597853099, 14097.718045639234, 14108.224047677271, 14115.647108822362, 6765.1205343305055, 6786.626735529593, 6877.449804015667, 6989.0564773755905, 6995.755148569776, 6144.41628045335, 6166.599171053867, 6350.491960643138, 6351.142595749515, 6366.490680745529, 4316.956830431655, 4428.357888106271, 4453.977730111394, 4482.517688969373, 4515.2324104902245, 1691.9830801692071, 1698.507432844486, 1731.8874273172203, 1807.0, 1893.3751861885544, 795.8806179073185, 818.8607936650784, 820.7373640435003, 828.4201059258543, 871.6861929705301, 16354.836451635569, 16612.169391530377, 17206.33301838217, 17601.383951561635, 17628.0, 876.6624849433014, 882.1178821178821, 884.6815146547237, 888.7200531832452, 910.1717437132178, 9077.228435582918, 9520.8571871422, 9601.135897769094, 9642.614295428244, 9728.0, 334218.0, 338899.0, 341762.0, 359979.0, 361178.0, 69824.0, 71563.6421817898, 72586.27413725795, 75352.0, 75414.0, 874.3660845886682, 888.9599968001455, 899.9626261367883, 915.5971372596036, 916.8258030974093, 14811.481598144444, 14949.252537373306, 15936.282867271233, 17088.145592720066, 17418.129093545525, 35073.82463087668, 38248.61751382562, 38950.4157437633, 39900.8004959985, 40952.38571421371, 49324.50675493343, 50863.49136508587, 50984.0, 52263.73868130635, 52583.21125183202, 7349.595772232578, 7393.112826460859, 7393.778186654409, 7556.546607203585, 7719.266669666373, 8874.023857375554, 11351.943240283746, 11382.94308528452, 11411.714707132056, 11539.769204616028, 10307.123894469054, 10355.482225888525, 10665.573377064831, 10732.034116929513, 11146.442677866236, 9734.853977190489, 10041.196704263788, 10277.794444111225, 10400.479976001321, 10567.89432105669, 10069.395836249849, 10282.177425805769, 10289.073983341535, 10505.264631475724, 10935.671929842118, 6302.401271879165, 6831.180258369028, 6922.376986071277, 7261.5280006799385, 7333.0, 9174.724758257264, 10239.232057595562, 10450.425226612306, 10559.683209503728, 10863.837042444527], "value": 8149.091165659363, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1234.7160153164778, 1330.9267990260535, 1404.2487269310918, 1436.755751522241, 1682.2682133272028, 6722.495812814034, 7560.810979725509, 7887.921120788797, 7892.131865494791, 7966.800829979239, 7746.573938433384, 7774.37804975602, 7829.80425489363, 7837.294643482085, 7855.096663883655, 2172.9239476618322, 2182.2580322690283, 2182.694422780812, 2188.1684959715285, 2191.5726433345503, 2156.6764985252257, 2201.1085510368325, 2202.526456811785, 2202.581509513195, 2204.360735386736, 2163.891805409731, 2187.8030977212047, 2191.594555007329, 2192.375173075674, 2201.856879302848, 2157.9352619421443, 2158.2985529702833, 2167.8590891592075, 2169.6745488176743, 2175.0755928730227, 2059.6498595238845, 2118.8834614096218, 2121.4272146520507, 2124.3095993802076, 2126.489642485808, 7572.39420846331, 7581.924180758177, 7849.45053846231, 7940.1662825403655, 7974.3221826144845, 4361.0, 4503.887402814923, 4524.638028957708, 4567.200739870509, 4569.246074397721, 2874.4107457971068, 2977.7766667500023, 3041.1180757580273, 3054.3433161870084, 3055.3736484020947, 949.3639261694681, 961.053362437998, 971.4754032822267, 982.4940155819759, 994.9005099490065, 10676.786464270748, 10842.945785271102, 10881.401522916236, 10921.399323037229, 10955.4522273886, 4252.340887162495, 4368.191884501377, 4381.058072514425, 4399.20814253431, 4432.4237849080055, 9245.936717277466, 9277.304202184863, 9278.628854845865, 9284.350095493252, 9343.71968840936, 4534.093181363674, 4545.204589196877, 4550.453945526492, 4566.45202575693, 4571.26859702446, 3511.982440087834, 3611.855525778992, 3618.5838628558054, 4066.044479547304, 4112.568180341081, 3642.6357364263363, 3691.9815400922826, 3747.3254814133174, 3768.8680896169053, 3783.981080094637, 1192.469351138735, 1196.8025275829564, 1206.7707135644375, 1230.0, 1236.1717649174896, 740.2782287269869, 740.9222031686595, 790.8734602463693, 808.6401551309729, 813.4062134641626, 5025.974870125699, 5131.1277082895995, 5265.552428043583, 5331.546818520392, 5389.51494365509, 839.8320335932716, 841.5497708725802, 853.88899443072, 884.7699598104539, 901.2429559170329, 3441.7246620270316, 3500.9124771880906, 3529.2235708144167, 3578.355895938704, 3684.705223582107, 9567.665131720356, 9888.901110988798, 9923.156531694887, 9949.751256218653, 9959.352642078242, 9867.0, 9869.950650246703, 9896.752581185385, 9909.554070066864, 9910.851337229948, 7101.254368291255, 7245.311695388929, 7278.672459739324, 7279.963600181965, 7281.126264848146, 4988.12707776145, 5008.647665130467, 5175.792968281377, 5328.987492376436, 5449.548099541909, 8707.172818582225, 8870.467771933705, 8895.066018068268, 8940.195382415613, 8945.865812012695, 7018.613976231356, 8692.565371731262, 8874.51190184546, 8924.107589241024, 9182.403143795633, 6610.074589557562, 6829.2487826338065, 6881.793546193622, 6897.172339319314, 6907.102076729993, 7433.10802703679, 7493.737719179802, 7498.062742157231, 7503.287187717158, 7512.8873066905135, 6855.383015528626, 6881.208661004049, 6922.584644921119, 6981.232064472802, 7223.855522889407, 6883.793486195422, 6934.16789985205, 7003.0, 7027.929720702932, 7058.223595404604, 6050.546209034252, 6229.0967809668255, 6286.591371560834, 6298.748050077946, 6310.242770867525, 4570.268756998864, 4651.953480465152, 4754.263089221176, 4754.524547545356, 4803.03939212152, 4509.819607215674, 4735.526447355237, 4759.405074365704, 4786.497417771223, 4819.0], "value": 4144.387056868757, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.39574860906663, 304.70595874980654, 308.0834517311001, 308.3893890097606, 309.1883805011844, 4771.165046116928, 4777.9522204777895, 4779.283107533872, 4791.784369703363, 4807.399075115611, 4738.123447162277, 4748.881277968053, 4752.07334569759, 4756.143894099061, 4761.119192949298, 3604.639536046394, 3683.121607979923, 3685.5208822853124, 3696.482492451059, 3700.130469339703, 3626.746127771044, 3695.353313170198, 3725.329440700673, 3766.378547539666, 3812.866549670762, 3728.7949162796035, 3739.981300093509, 3744.6817020553285, 3745.513083299167, 3756.0985363512696, 3614.0964758810296, 3733.3653278942375, 3740.532433445833, 3745.700343972476, 3753.493278407407, 3118.8284644344553, 3236.757243206769, 3286.819224942651, 3303.900882973515, 3304.8512816923294, 4590.655700822452, 4638.791254393526, 4639.188142075157, 4641.419822522184, 4641.605463535603, 4255.8084886180195, 4293.914121717548, 4294.506131794852, 4303.419038429804, 4308.67684923632, 4703.800530864608, 4973.626977976666, 4976.4277108132665, 4976.726280054596, 4979.0, 3657.835397407123, 3659.70722342212, 3662.322470342995, 3664.3770559005034, 3666.1934374437847, 5198.818041368534, 5207.765650545734, 5223.347081614798, 5230.163173892197, 5233.110371236823, 3764.79293638847, 3767.2088861339425, 3767.3407153747985, 3767.8869633910476, 3772.9817744102443, 3583.4445660922597, 3768.6985041197186, 3803.5245594300713, 3819.961800382016, 3821.3885778275344, 4281.336392859112, 4285.61429471349, 4290.506591741927, 4291.420658211102, 4296.334068219431, 4985.651004429655, 4989.401271847401, 4990.4011518618, 4992.700437973734, 5011.649184557046, 1242.9254244745164, 1298.4546490474024, 1298.759684501318, 1313.756954963335, 1314.9480415667429, 831.8211584509238, 853.6938484119307, 867.3538214030588, 867.6659486097772, 874.2612492443875, 3915.941260881089, 3928.823202955874, 3942.1025546223505, 3944.36890097583, 3949.5458022327225, 4529.660275479287, 4535.387722657465, 4538.909221815546, 4543.227651299287, 4544.977275113603, 3841.500604921398, 3925.450436938831, 3942.7634341939574, 3980.2238563480423, 3987.182627561343, 2457.299669594157, 2460.2127319258025, 2539.733328000533, 2737.8083534152815, 2761.6962134165224, 4660.207764679944, 4737.692050016738, 4824.252240902666, 4846.903061938741, 4851.733154676526, 5209.6874187548865, 5212.4266330703595, 5233.162693968947, 5233.947660523346, 5248.895022099537, 4753.215719406259, 4873.439554451284, 4882.145624515767, 4887.780049897692, 4898.926516102332, 5030.0, 5105.897882042264, 5115.5396014358885, 5118.539331460186, 5129.692218466755, 5021.7740201690285, 5028.698278103326, 5031.698098114125, 5038.614381045242, 5040.319556859924, 4660.021395506846, 4856.271559266138, 4874.58566021878, 4877.878053048702, 4878.512148785093, 3635.4546817977516, 3663.2856592964117, 3673.7979411132646, 3675.8713445029293, 3677.558692956862, 5195.922061169161, 5199.896002080013, 5200.0, 5200.843974680765, 5202.115640341075, 4881.0, 5026.888706743103, 5034.194528875362, 5036.420811606712, 5058.342415485963, 4995.575376093073, 5033.615755667221, 5041.596672266283, 5041.798328066836, 5050.015247026795, 4970.229614409773, 4973.179425394769, 4973.602111831117, 4983.825566105169, 4984.576311013459, 4865.635077369141, 5060.343319757157, 5064.822731204537, 5072.264521644414, 5075.28945947575, 4928.383952005999, 4944.208926571731, 4956.281339205723, 4968.403791545038, 4973.204287314157], "value": 3745.861042998522, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.3409189672482, 666.7066490744076, 682.8873235916076, 686.8488932434868, 733.9577799524675, 11755.82441755824, 12725.0, 12726.554570590031, 12736.108472406935, 12741.299228542439, 13294.601161965133, 13310.401031953561, 13324.533641322556, 13333.266670333127, 13335.0, 620.9596376235553, 747.7644541969289, 756.4553521464537, 765.4182821055982, 769.6728890221661, 769.2653515892338, 770.8997830282084, 771.3289438188783, 773.6479901644739, 774.0827119862952, 823.6911158315631, 824.6165533027141, 825.0264687668549, 825.0470706334194, 825.0923983618002, 653.5621133840339, 671.2347923367316, 672.0758956434902, 673.4343151752552, 820.958952052398, 580.5906835680835, 595.8272101090679, 599.3886236039259, 600.3396264109444, 600.414595769126, 12625.305608191546, 12627.116101872873, 12690.555830545887, 12701.491940322376, 12714.872851271553, 12305.56930507428, 12720.554780582728, 12781.808272875915, 12900.290484023375, 13249.47002119914, 11309.886901131047, 11434.771304573862, 11637.825432618518, 11720.120990925629, 11932.582359617458, 4065.3698676705158, 4070.816813243411, 4134.855280065213, 4223.429836972, 4272.423222864935, 65381.673091634715, 66561.0, 66638.3336166637, 67817.66091169562, 67871.0, 9822.656207032862, 9983.800323993624, 10274.0, 10547.525361358757, 10666.573337066586, 17500.912495437442, 17701.645967080585, 17743.11284435773, 17744.0, 17751.0, 6503.9349606504275, 6520.543561950618, 6610.8016759497295, 6698.062271282024, 6886.896696549556, 3632.328019316435, 3657.104009517685, 3742.3450896093077, 3742.5696044954634, 3782.451544526028, 2838.2194896403244, 2963.577482808264, 2964.051503518853, 2966.006387860048, 2967.2433529449854, 485.5605676862445, 487.2082865343816, 497.2417063977463, 515.4253007896243, 516.0, 535.9356877174764, 546.4289817141017, 559.426587747562, 564.9858753531195, 573.2547688005576, 6941.930580694128, 7184.5940249907735, 8651.6971905983, 8717.869231961526, 8757.912420875837, 613.4999975020434, 633.4583930739152, 635.6027482823235, 637.0317117980643, 640.4748106552676, 3901.6098390160755, 3978.3634618461488, 3988.7407318524783, 4020.1758639478835, 4093.6111069448357, 80877.59561202273, 100318.0, 103286.0, 104185.0, 107625.4618726917, 50505.0, 55910.0, 76971.0, 86169.13830861611, 86936.0, 43036.56963430388, 45113.548864510936, 51411.48588514142, 70235.64882175556, 72636.46271835454, 7729.729459468892, 8249.29880960101, 8253.174682531939, 8335.49987000782, 8410.537420441935, 33980.0, 44764.298681349006, 45114.323285151404, 45198.77400612976, 45529.0, 34812.477812833335, 37021.0, 40050.59949400469, 40050.79974600108, 40119.598804011584, 10764.246502745045, 10804.621838235624, 10876.619318323821, 11260.39667306454, 11386.0, 12092.879071209527, 12627.93686031564, 12878.291693956922, 12994.350282486026, 13202.273874936587, 11217.214794964275, 11359.658039978061, 11570.768584628091, 11884.168108232341, 12255.080868934687, 11069.114470842153, 11150.776984460428, 11456.140789440658, 11631.709207269885, 12006.0, 10011.749706257402, 10084.54619542137, 10805.837912431163, 11029.779404412027, 11045.171612129283, 9544.618215271312, 9714.368566043184, 9717.562709678223, 9757.365771225132, 10081.270024764615, 7997.480163789335, 9034.0, 9366.391184572982, 9506.873401534327, 9742.0], "value": 6358.452228909393, "unit": "score"}], "name": "dromaeo_css", "value": 6375.312512740357, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 115.0, 114.0, 111.0, 114.0, 114.0, 114.0, 114.0, 114.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 128.0, 126.0, 178.0, 122.0, 126.0, 145.0, 121.0, 180.0, 121.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 162.0, 161.0, 162.0, 161.0, 160.0, 161.0, 162.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 110.0, 77.0, 77.0, 75.0, 77.0, 125.0, 76.0], "value": 84.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 127.0, 86.0, 87.0, 86.0, 128.0, 86.0, 86.0, 132.0], "value": 99.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0, 147.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 66.0, 65.0, 65.0, 69.0, 66.0, 66.0, 67.0, 65.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 81.0, 82.0, 82.0, 81.0, 90.0, 84.0, 82.0, 93.0, 82.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 132.0, 133.0, 131.0, 130.0, 131.0, 133.0, 135.0, 148.0, 129.0], "value": 133.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 170.0, 169.0, 171.0, 168.0, 170.0, 169.0, 170.0, 170.0, 176.0], "value": 170.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 68.0, 70.0, 67.0, 67.0, 67.0, 67.0, 67.0, 72.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1542.8999999999999, "alertThreshold": 2.0}]} 08:36:27 INFO - Return code: 0 08:36:27 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:36:27 INFO - # TBPL SUCCESS # 08:36:27 INFO - Running post-action listener: _resource_record_post_action 08:36:27 INFO - [mozharness: 2016-08-16 15:36:27.900796Z] Finished run-tests step (success) 08:36:27 INFO - Running post-run listener: _resource_record_post_run 08:36:27 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 395997184; Read time: 0; Write time: 305900 08:36:27 INFO - TinderboxPrint: CPU usage
13.0% 08:36:27 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:36:27 INFO - TinderboxPrint: I/O write bytes / time
395,997,184 / 305,900 08:36:27 INFO - TinderboxPrint: CPU idle
8,326.0 (87.0%) 08:36:27 INFO - TinderboxPrint: CPU user
1,200.7 (12.5%) 08:36:27 INFO - TinderboxPrint: Swap in / out
0 / 0 08:36:27 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113639424; Read time: 0; Write time: 117212 08:36:28 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 281743360; Read time: 0; Write time: 188688 08:36:28 INFO - Running post-run listener: _upload_blobber_files 08:36:28 INFO - Blob upload gear active. 08:36:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:36:28 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:36:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:36:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:36:28 INFO - (blobuploader) - INFO - Open directory for files ... 08:36:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:36:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:36:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:29 INFO - (blobuploader) - INFO - Done attempting. 08:36:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:36:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:36:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:30 INFO - (blobuploader) - INFO - Done attempting. 08:36:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:36:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:36:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:36 INFO - (blobuploader) - INFO - Done attempting. 08:36:36 INFO - (blobuploader) - INFO - Iteration through files over. 08:36:36 INFO - Return code: 0 08:36:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:36:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:36:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9969723e5d23669a18c0a963d629f79e738b6b86cdbfdd6c1acc8ba782a3e9464697c5fdb84f43664c1f916c127eb12a3a0bf3af098a2dcef4c0c600081f31d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1adc92e616bf6d6dd70591c315dbcd7a5fae17b68232b910ed56563bf0e750da7b93f2fb20f221c5f516961a43046a5fe9a8d134364e160dce27de94da2a60f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4f6d2f07db7ef62cefa237326f812aee3f36ba225adfff21c97d49577691c1c8c5e22a612846b3b0581719740889f57f3aa8638590de063ce40b61df581f5b87"} 08:36:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:36:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:36:36 INFO - Contents: 08:36:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9969723e5d23669a18c0a963d629f79e738b6b86cdbfdd6c1acc8ba782a3e9464697c5fdb84f43664c1f916c127eb12a3a0bf3af098a2dcef4c0c600081f31d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1adc92e616bf6d6dd70591c315dbcd7a5fae17b68232b910ed56563bf0e750da7b93f2fb20f221c5f516961a43046a5fe9a8d134364e160dce27de94da2a60f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4f6d2f07db7ef62cefa237326f812aee3f36ba225adfff21c97d49577691c1c8c5e22a612846b3b0581719740889f57f3aa8638590de063ce40b61df581f5b87"} 08:36:36 INFO - Running post-run listener: copy_logs_to_upload_dir 08:36:36 INFO - Copying logs to upload dir... 08:36:36 INFO - mkdir: /builds/slave/test/build/upload/logs 08:36:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.572301 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 44 secs) (at 2016-08-16 08:36:35.836772) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 08:36:35.844882) ========= 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=62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9969723e5d23669a18c0a963d629f79e738b6b86cdbfdd6c1acc8ba782a3e9464697c5fdb84f43664c1f916c127eb12a3a0bf3af098a2dcef4c0c600081f31d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1adc92e616bf6d6dd70591c315dbcd7a5fae17b68232b910ed56563bf0e750da7b93f2fb20f221c5f516961a43046a5fe9a8d134364e160dce27de94da2a60f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4f6d2f07db7ef62cefa237326f812aee3f36ba225adfff21c97d49577691c1c8c5e22a612846b3b0581719740889f57f3aa8638590de063ce40b61df581f5b87"} build_url:https://queue.taskcluster.net/v1/task/EC09TPXmQlWkARIJzAJVzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/EC09TPXmQlWkARIJzAJVzw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9969723e5d23669a18c0a963d629f79e738b6b86cdbfdd6c1acc8ba782a3e9464697c5fdb84f43664c1f916c127eb12a3a0bf3af098a2dcef4c0c600081f31d4", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/b1adc92e616bf6d6dd70591c315dbcd7a5fae17b68232b910ed56563bf0e750da7b93f2fb20f221c5f516961a43046a5fe9a8d134364e160dce27de94da2a60f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4f6d2f07db7ef62cefa237326f812aee3f36ba225adfff21c97d49577691c1c8c5e22a612846b3b0581719740889f57f3aa8638590de063ce40b61df581f5b87"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-16 08:36:35.873507) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 08:36:35.873874) ========= 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=62c568580acbfdaac3eec7be000001dc-1471360549.844738-440187865 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004465 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-16 08:36:35.953403) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 08:36:35.953786) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-16 08:36:35.954077) ========= ========= Total master_lag: 0.19 =========