builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-024 starttime: 1468504659.48 results: success (0) buildid: 20160714033529 builduid: e5a53da1c33441ef84834b57e1ca3076 revision: d868ba1645e6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 06:57:39.475969) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 06:57:39.476450) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 06:57:39.476824) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 06:57:39.493151) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:57:39.493467) ========= 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=41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-14 06:57:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 25.2M=0s 2016-07-14 06:57:39 (25.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092801 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:57:39.603168) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:57:39.603579) ========= 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=41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018639 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 06:57:39.654190) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-14 06:57:39.657625) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d868ba1645e6 --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 d868ba1645e6 --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=41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-14 06:57:39,910 Setting DEBUG logging. 2016-07-14 06:57:39,910 attempt 1/10 2016-07-14 06:57:39,910 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d868ba1645e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 06:57:40,556 unpacking tar archive at: fx-team-d868ba1645e6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.985330 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-14 06:57:40.657924) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 06:57:40.658317) ========= script_repo_revision: d868ba1645e6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 06:57:40.658807) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 06:57:40.659125) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 06:57:40.669766) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-14 06:57:40.670086) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:57:41 INFO - MultiFileLogger online at 20160714 06:57:41 in /builds/slave/test 06:57:41 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:57:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:57:41 INFO - {'append_to_log': False, 06:57:41 INFO - 'base_work_dir': '/builds/slave/test', 06:57:41 INFO - 'blob_upload_branch': 'Fx-Team', 06:57:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:57:41 INFO - 'branch': 'Fx-Team', 06:57:41 INFO - 'buildbot_json_path': 'buildprops.json', 06:57:41 INFO - 'config_files': ('talos/linux_config.py',), 06:57:41 INFO - 'default_actions': ('clobber', 06:57:41 INFO - 'read-buildbot-config', 06:57:41 INFO - 'download-and-extract', 06:57:41 INFO - 'populate-webroot', 06:57:41 INFO - 'create-virtualenv', 06:57:41 INFO - 'install', 06:57:41 INFO - 'run-tests'), 06:57:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:57:41 INFO - 'download_minidump_stackwalk': True, 06:57:41 INFO - 'download_symbols': 'ondemand', 06:57:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:57:41 INFO - 'tooltool.py': '/tools/tooltool.py', 06:57:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:57:41 INFO - '/tools/misc-python/virtualenv.py')}, 06:57:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:57:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:57:41 INFO - 'installer_path': 'installer.exe', 06:57:41 INFO - 'log_level': 'info', 06:57:41 INFO - 'log_name': 'talos', 06:57:41 INFO - 'log_to_console': True, 06:57:41 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:57:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:57:41 INFO - 'opt_config_files': (), 06:57:41 INFO - 'pip_index': False, 06:57:41 INFO - 'sps_profile': False, 06:57:41 INFO - 'sps_profile_interval': 0, 06:57:41 INFO - 'suite': 'dromaeojs-e10s', 06:57:41 INFO - 'system_bits': '32', 06:57:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:57:41 INFO - 'title': 'talos-linux64-ix-024', 06:57:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:57:41 INFO - 'use_talos_json': True, 06:57:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:57:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:57:41 INFO - 'work_dir': 'build'} 06:57:41 INFO - ##### 06:57:41 INFO - ##### Running clobber step. 06:57:41 INFO - ##### 06:57:41 INFO - Running pre-action listener: _resource_record_pre_action 06:57:41 INFO - Running main action method: clobber 06:57:41 INFO - rmtree: /builds/slave/test/build 06:57:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:57:41 INFO - Running post-action listener: _resource_record_post_action 06:57:41 INFO - ##### 06:57:41 INFO - ##### Finished clobber step (success) 06:57:41 INFO - ##### 06:57:41 INFO - ##### 06:57:41 INFO - ##### Running read-buildbot-config step. 06:57:41 INFO - ##### 06:57:41 INFO - Running pre-action listener: _resource_record_pre_action 06:57:41 INFO - Running main action method: read_buildbot_config 06:57:41 INFO - Using buildbot properties: 06:57:41 INFO - { 06:57:41 INFO - "project": "", 06:57:41 INFO - "product": "firefox", 06:57:41 INFO - "script_repo_revision": "production", 06:57:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 06:57:41 INFO - "repository": "", 06:57:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 06:57:41 INFO - "buildid": "20160714033529", 06:57:41 INFO - "pgo_build": "True", 06:57:41 INFO - "basedir": "/builds/slave/test", 06:57:41 INFO - "buildnumber": 621, 06:57:41 INFO - "slavename": "talos-linux64-ix-024", 06:57:41 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:57:41 INFO - "platform": "ubuntu64_hw", 06:57:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 06:57:41 INFO - "branch": "fx-team", 06:57:41 INFO - "repo_path": "integration/fx-team", 06:57:41 INFO - "revision": "d868ba1645e6", 06:57:41 INFO - "stage_platform": "linux64-pgo", 06:57:41 INFO - "builduid": "e5a53da1c33441ef84834b57e1ca3076", 06:57:41 INFO - "slavebuilddir": "test" 06:57:41 INFO - } 06:57:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 06:57:41 INFO - Running post-action listener: _resource_record_post_action 06:57:41 INFO - ##### 06:57:41 INFO - ##### Finished read-buildbot-config step (success) 06:57:41 INFO - ##### 06:57:41 INFO - ##### 06:57:41 INFO - ##### Running download-and-extract step. 06:57:41 INFO - ##### 06:57:41 INFO - Running pre-action listener: _resource_record_pre_action 06:57:41 INFO - Running main action method: download_and_extract 06:57:41 INFO - mkdir: /builds/slave/test/build/tests 06:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:41 INFO - https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 06:57:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:57:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:57:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:57:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 06:57:42 INFO - Downloaded 1361 bytes. 06:57:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 06:57:42 INFO - Using the following test package requirements: 06:57:42 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:57:42 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:57:42 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:57:42 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:42 INFO - u'jsshell-linux-x86_64.zip'], 06:57:42 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:57:42 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 06:57:42 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:57:42 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:57:42 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:57:42 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 06:57:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:57:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:57:42 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:42 INFO - https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:57:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:57:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:57:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:57:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:57:43 INFO - Downloaded 24326501 bytes. 06:57:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:57:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:57:44 INFO - Return code: 0 06:57:44 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 06:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:44 INFO - https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:57:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:57:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:57:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 06:57:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:57:45 INFO - Downloaded 24326501 bytes. 06:57:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:57:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 06:57:47 INFO - Return code: 0 06:57:47 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:47 INFO - https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:57:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:57:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:57:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 06:57:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:57:48 INFO - Downloaded 14403317 bytes. 06:57:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:57:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 06:57:48 INFO - Return code: 0 06:57:48 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:48 INFO - https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:57:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:57:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:57:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:57:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 06:57:49 INFO - Downloaded 60816815 bytes. 06:57:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:57:49 INFO - mkdir: /builds/slave/test/properties 06:57:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:57:49 INFO - Writing to file /builds/slave/test/properties/build_url 06:57:49 INFO - Contents: 06:57:49 INFO - build_url:https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 06:57:50 INFO - Running post-action listener: _resource_record_post_action 06:57:50 INFO - Running post-action listener: set_extra_try_arguments 06:57:50 INFO - ##### 06:57:50 INFO - ##### Finished download-and-extract step (success) 06:57:50 INFO - ##### 06:57:50 INFO - ##### 06:57:50 INFO - ##### Running populate-webroot step. 06:57:50 INFO - ##### 06:57:50 INFO - Running pre-action listener: _resource_record_pre_action 06:57:50 INFO - Running main action method: populate_webroot 06:57:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:57:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:57:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:57:50 INFO - '--tppagecycles', 06:57:50 INFO - '7'], 06:57:50 INFO - 'tests': ['tsvgm']}}, 06:57:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:57:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:57:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:57:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:57:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:57:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:57:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:50 INFO - 'talos_options': ['--disable-e10s'], 06:57:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:57:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:57:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:50 INFO - 'talos_options': ['--disable-e10s'], 06:57:50 INFO - 'tests': ['damp', 'tps']}, 06:57:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:50 INFO - 'tests': ['damp', 'tps']}, 06:57:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:57:50 INFO - 'tests': ['dromaeo_dom']}, 06:57:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:57:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:57:50 INFO - 'tests': ['basic_compositor_video']}, 06:57:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:57:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:57:50 INFO - 'tests': ['a11yr', 06:57:50 INFO - 'ts_paint', 06:57:50 INFO - 'tpaint', 06:57:50 INFO - 'sessionrestore', 06:57:50 INFO - 'sessionrestore_no_auto_restore', 06:57:50 INFO - 'tabpaint']}, 06:57:50 INFO - 'other-e10s': {'tests': ['a11yr', 06:57:50 INFO - 'ts_paint', 06:57:50 INFO - 'tpaint', 06:57:50 INFO - 'sessionrestore', 06:57:50 INFO - 'sessionrestore_no_auto_restore', 06:57:50 INFO - 'tabpaint']}, 06:57:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:57:50 INFO - 'ts_paint', 06:57:50 INFO - 'tpaint', 06:57:50 INFO - 'sessionrestore', 06:57:50 INFO - 'sessionrestore_no_auto_restore', 06:57:50 INFO - 'tabpaint']}, 06:57:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:57:50 INFO - 'ts_paint', 06:57:50 INFO - 'tpaint', 06:57:50 INFO - 'sessionrestore', 06:57:50 INFO - 'sessionrestore_no_auto_restore', 06:57:50 INFO - 'tabpaint']}, 06:57:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:57:50 INFO - 'tests': ['a11yr', 06:57:50 INFO - 'ts_paint', 06:57:50 INFO - 'tpaint', 06:57:50 INFO - 'sessionrestore', 06:57:50 INFO - 'sessionrestore_no_auto_restore', 06:57:50 INFO - 'tabpaint']}, 06:57:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:57:50 INFO - 'tests': ['a11yr', 06:57:50 INFO - 'ts_paint', 06:57:50 INFO - 'tpaint', 06:57:50 INFO - 'sessionrestore', 06:57:50 INFO - 'sessionrestore_no_auto_restore', 06:57:50 INFO - 'tabpaint']}, 06:57:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:57:50 INFO - 'tests': ['tsvgx', 06:57:50 INFO - 'tsvgr_opacity', 06:57:50 INFO - 'tart', 06:57:50 INFO - 'tscrollx', 06:57:50 INFO - 'cart']}, 06:57:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:57:50 INFO - 'tsvgr_opacity', 06:57:50 INFO - 'tart', 06:57:50 INFO - 'tscrollx', 06:57:50 INFO - 'cart']}, 06:57:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:50 INFO - 'talos_options': ['--disable-e10s'], 06:57:50 INFO - 'tests': ['tp5o']}, 06:57:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:50 INFO - 'tests': ['tp5o']}, 06:57:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:50 INFO - 'talos_options': ['--disable-e10s', 06:57:50 INFO - '--xperf_path', 06:57:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:57:50 INFO - 'tests': ['tp5n']}, 06:57:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:57:50 INFO - 'talos_options': ['--xperf_path', 06:57:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:57:50 INFO - 'tests': ['tp5n']}}, 06:57:50 INFO - 'talos.zip': {'path': '', 06:57:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:57:50 INFO - Running post-action listener: _resource_record_post_action 06:57:50 INFO - ##### 06:57:50 INFO - ##### Finished populate-webroot step (success) 06:57:50 INFO - ##### 06:57:50 INFO - ##### 06:57:50 INFO - ##### Running create-virtualenv step. 06:57:50 INFO - ##### 06:57:50 INFO - Running pre-action listener: _resource_record_pre_action 06:57:50 INFO - Running main action method: create_virtualenv 06:57:50 INFO - Creating virtualenv /builds/slave/test/build/venv 06:57:50 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 06:57:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:57:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:57:50 INFO - Using real prefix '/usr' 06:57:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:57:51 INFO - Installing distribute.............................................................................................................................................................................................done. 06:57:53 INFO - Installing pip.................done. 06:57:53 INFO - Return code: 0 06:57:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:53 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 0x265a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29193b0>, '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 0x291a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291a740>, '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': '41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648', '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 06:57:53 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 06:57:53 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 06:57:53 INFO - Using env: {'DISPLAY': ':0', 06:57:53 INFO - 'HOME': '/home/cltbld', 06:57:53 INFO - 'LANG': 'en_US.UTF-8', 06:57:53 INFO - 'LANGUAGE': 'en_US:en', 06:57:53 INFO - 'LOGNAME': 'cltbld', 06:57:53 INFO - 'MAIL': '/var/mail/cltbld', 06:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:53 INFO - 'MOZ_NO_REMOTE': '1', 06:57:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:53 INFO - 'NO_EM_RESTART': '1', 06:57:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:53 INFO - 'PWD': '/builds/slave/test', 06:57:53 INFO - 'SHELL': '/bin/bash', 06:57:53 INFO - 'SHLVL': '1', 06:57:53 INFO - 'TERM': 'linux', 06:57:53 INFO - 'TMOUT': '86400', 06:57:53 INFO - 'USER': 'cltbld', 06:57:53 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648', 06:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:53 INFO - '_': '/tools/buildbot/bin/python'} 06:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:53 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 06:57:53 INFO - Cleaning up... 06:57:53 INFO - Return code: 0 06:57:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:53 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 0x265a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29193b0>, '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 0x291a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291a740>, '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': '41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648', '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 06:57:53 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 06:57:53 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 06:57:53 INFO - Using env: {'DISPLAY': ':0', 06:57:53 INFO - 'HOME': '/home/cltbld', 06:57:53 INFO - 'LANG': 'en_US.UTF-8', 06:57:53 INFO - 'LANGUAGE': 'en_US:en', 06:57:53 INFO - 'LOGNAME': 'cltbld', 06:57:53 INFO - 'MAIL': '/var/mail/cltbld', 06:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:53 INFO - 'MOZ_NO_REMOTE': '1', 06:57:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:53 INFO - 'NO_EM_RESTART': '1', 06:57:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:53 INFO - 'PWD': '/builds/slave/test', 06:57:53 INFO - 'SHELL': '/bin/bash', 06:57:53 INFO - 'SHLVL': '1', 06:57:53 INFO - 'TERM': 'linux', 06:57:53 INFO - 'TMOUT': '86400', 06:57:53 INFO - 'USER': 'cltbld', 06:57:53 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648', 06:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:53 INFO - '_': '/tools/buildbot/bin/python'} 06:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:53 INFO - Downloading/unpacking psutil>=3.1.1 06:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:57:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:57:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:57:55 INFO - Installing collected packages: psutil 06:57:55 INFO - Running setup.py install for psutil 06:57:55 INFO - building 'psutil._psutil_linux' extension 06:57:55 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 06:57:55 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 06:57:55 INFO - building 'psutil._psutil_posix' extension 06:57:55 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 06:57:55 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 06:57:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:57:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:57:56 INFO - Successfully installed psutil 06:57:56 INFO - Cleaning up... 06:57:56 INFO - Return code: 0 06:57:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:56 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 0x265a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29193b0>, '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 0x291a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291a740>, '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': '41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648', '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 06:57:56 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 06:57:56 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 06:57:56 INFO - Using env: {'DISPLAY': ':0', 06:57:56 INFO - 'HOME': '/home/cltbld', 06:57:56 INFO - 'LANG': 'en_US.UTF-8', 06:57:56 INFO - 'LANGUAGE': 'en_US:en', 06:57:56 INFO - 'LOGNAME': 'cltbld', 06:57:56 INFO - 'MAIL': '/var/mail/cltbld', 06:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:56 INFO - 'MOZ_NO_REMOTE': '1', 06:57:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:56 INFO - 'NO_EM_RESTART': '1', 06:57:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:56 INFO - 'PWD': '/builds/slave/test', 06:57:56 INFO - 'SHELL': '/bin/bash', 06:57:56 INFO - 'SHLVL': '1', 06:57:56 INFO - 'TERM': 'linux', 06:57:56 INFO - 'TMOUT': '86400', 06:57:56 INFO - 'USER': 'cltbld', 06:57:56 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648', 06:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:56 INFO - '_': '/tools/buildbot/bin/python'} 06:57:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:57:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:57:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:57:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:57:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:57:58 INFO - Installing collected packages: mozsystemmonitor 06:57:58 INFO - Running setup.py install for mozsystemmonitor 06:57:58 INFO - Successfully installed mozsystemmonitor 06:57:58 INFO - Cleaning up... 06:57:58 INFO - Return code: 0 06:57:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:57:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:57:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:57:58 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 0x265a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29193b0>, '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 0x291a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291a740>, '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': '41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648', '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 06:57:58 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 06:57:58 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 06:57:58 INFO - Using env: {'DISPLAY': ':0', 06:57:58 INFO - 'HOME': '/home/cltbld', 06:57:58 INFO - 'LANG': 'en_US.UTF-8', 06:57:58 INFO - 'LANGUAGE': 'en_US:en', 06:57:58 INFO - 'LOGNAME': 'cltbld', 06:57:58 INFO - 'MAIL': '/var/mail/cltbld', 06:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:57:58 INFO - 'MOZ_NO_REMOTE': '1', 06:57:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:57:58 INFO - 'NO_EM_RESTART': '1', 06:57:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:57:58 INFO - 'PWD': '/builds/slave/test', 06:57:58 INFO - 'SHELL': '/bin/bash', 06:57:58 INFO - 'SHLVL': '1', 06:57:58 INFO - 'TERM': 'linux', 06:57:58 INFO - 'TMOUT': '86400', 06:57:58 INFO - 'USER': 'cltbld', 06:57:58 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648', 06:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:57:58 INFO - '_': '/tools/buildbot/bin/python'} 06:57:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:57:58 INFO - Downloading/unpacking jsonschema==2.5.1 06:57:58 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 06:57:58 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 06:57:58 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 06:57:58 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 06:57:58 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 06:57:58 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 06:58:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:58:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:58:00 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 06:58:00 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 06:58:00 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 06:58:00 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 06:58:00 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 06:58:00 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 06:58:00 INFO - Downloading functools32-3.2.3-2.tar.gz 06:58:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:58:00 INFO - warning: no files found matching '*.txt' 06:58:00 INFO - no previously-included directories found matching 'build' 06:58:00 INFO - no previously-included directories found matching 'dist' 06:58:00 INFO - no previously-included directories found matching '.git*' 06:58:00 INFO - Installing collected packages: jsonschema, functools32 06:58:00 INFO - Running setup.py install for functools32 06:58:00 INFO - warning: no files found matching '*.txt' 06:58:00 INFO - no previously-included directories found matching 'build' 06:58:00 INFO - no previously-included directories found matching 'dist' 06:58:00 INFO - no previously-included directories found matching '.git*' 06:58:01 INFO - Successfully installed jsonschema functools32 06:58:01 INFO - Cleaning up... 06:58:01 INFO - Return code: 0 06:58:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x265a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29193b0>, '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 0x291a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291a740>, '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': '41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648', '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 06:58:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 06:58:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 06:58:01 INFO - Using env: {'DISPLAY': ':0', 06:58:01 INFO - 'HOME': '/home/cltbld', 06:58:01 INFO - 'LANG': 'en_US.UTF-8', 06:58:01 INFO - 'LANGUAGE': 'en_US:en', 06:58:01 INFO - 'LOGNAME': 'cltbld', 06:58:01 INFO - 'MAIL': '/var/mail/cltbld', 06:58:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:01 INFO - 'MOZ_NO_REMOTE': '1', 06:58:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:01 INFO - 'NO_EM_RESTART': '1', 06:58:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:01 INFO - 'PWD': '/builds/slave/test', 06:58:01 INFO - 'SHELL': '/bin/bash', 06:58:01 INFO - 'SHLVL': '1', 06:58:01 INFO - 'TERM': 'linux', 06:58:01 INFO - 'TMOUT': '86400', 06:58:01 INFO - 'USER': 'cltbld', 06:58:01 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648', 06:58:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:01 INFO - '_': '/tools/buildbot/bin/python'} 06:58:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:01 INFO - Downloading/unpacking blobuploader==1.2.4 06:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:58:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:58:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:58:03 INFO - Downloading blobuploader-1.2.4.tar.gz 06:58:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:58:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:58:03 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 06:58:03 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 06:58:03 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 06:58:03 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 06:58:03 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 06:58:03 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 06:58:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:58:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:58:03 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 06:58:03 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 06:58:03 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 06:58:03 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 06:58:03 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 06:58:03 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 06:58:03 INFO - Downloading docopt-0.6.1.tar.gz 06:58:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:58:03 INFO - Installing collected packages: blobuploader, requests, docopt 06:58:03 INFO - Running setup.py install for blobuploader 06:58:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:58:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:58:04 INFO - Running setup.py install for requests 06:58:04 INFO - Running setup.py install for docopt 06:58:04 INFO - Successfully installed blobuploader requests docopt 06:58:04 INFO - Cleaning up... 06:58:04 INFO - Return code: 0 06:58:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:04 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 0x265a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29193b0>, '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 0x291a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291a740>, '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': '41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648', '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 06:58:04 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 06:58:04 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 06:58:04 INFO - Using env: {'DISPLAY': ':0', 06:58:04 INFO - 'HOME': '/home/cltbld', 06:58:04 INFO - 'LANG': 'en_US.UTF-8', 06:58:04 INFO - 'LANGUAGE': 'en_US:en', 06:58:04 INFO - 'LOGNAME': 'cltbld', 06:58:04 INFO - 'MAIL': '/var/mail/cltbld', 06:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:04 INFO - 'MOZ_NO_REMOTE': '1', 06:58:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:04 INFO - 'NO_EM_RESTART': '1', 06:58:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:04 INFO - 'PWD': '/builds/slave/test', 06:58:04 INFO - 'SHELL': '/bin/bash', 06:58:04 INFO - 'SHLVL': '1', 06:58:04 INFO - 'TERM': 'linux', 06:58:04 INFO - 'TMOUT': '86400', 06:58:04 INFO - 'USER': 'cltbld', 06:58:04 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648', 06:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:04 INFO - '_': '/tools/buildbot/bin/python'} 06:58:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:58:04 INFO - Running setup.py (path:/tmp/pip-JoAEkv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:58:04 INFO - Running setup.py (path:/tmp/pip-w1IJRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:58:04 INFO - Running setup.py (path:/tmp/pip-AuzYrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:58:04 INFO - Running setup.py (path:/tmp/pip-2DRWE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:58:05 INFO - Running setup.py (path:/tmp/pip-dVgbDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:58:05 INFO - Running setup.py (path:/tmp/pip-BS3iR8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:58:05 INFO - Running setup.py (path:/tmp/pip-zPr7bZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:58:05 INFO - Running setup.py (path:/tmp/pip-4YxzKr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:58:05 INFO - Running setup.py (path:/tmp/pip-SS8VfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:58:05 INFO - Running setup.py (path:/tmp/pip-yBp_SO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:58:05 INFO - Running setup.py (path:/tmp/pip-Z3aEpd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:58:05 INFO - Running setup.py (path:/tmp/pip-899WGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:58:05 INFO - Running setup.py (path:/tmp/pip-mDcHgI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:58:05 INFO - Running setup.py (path:/tmp/pip-l7YS_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:05 INFO - Running setup.py (path:/tmp/pip-yoDLiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:58:05 INFO - Running setup.py (path:/tmp/pip-5oag5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:58:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:58:05 INFO - Running setup.py (path:/tmp/pip-kVIEyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:58:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:58:05 INFO - Running setup.py install for manifestparser 06:58:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:58:06 INFO - Running setup.py install for mozcrash 06:58:06 INFO - Running setup.py install for mozdebug 06:58:06 INFO - Running setup.py install for mozdevice 06:58:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:58:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:58:06 INFO - Running setup.py install for mozfile 06:58:06 INFO - Running setup.py install for mozhttpd 06:58:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:58:06 INFO - Running setup.py install for mozinfo 06:58:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:58:06 INFO - Running setup.py install for mozInstall 06:58:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:58:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:58:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:58:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:58:06 INFO - Running setup.py install for mozleak 06:58:06 INFO - Running setup.py install for mozlog 06:58:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:58:06 INFO - Running setup.py install for moznetwork 06:58:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:58:07 INFO - Running setup.py install for mozprocess 06:58:07 INFO - Running setup.py install for mozprofile 06:58:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:58:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:58:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:58:07 INFO - Running setup.py install for mozrunner 06:58:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:58:07 INFO - Running setup.py install for mozscreenshot 06:58:07 INFO - Running setup.py install for moztest 06:58:07 INFO - Running setup.py install for mozversion 06:58:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:58:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:58:07 INFO - Cleaning up... 06:58:07 INFO - Return code: 0 06:58:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:07 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 0x265a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29193b0>, '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 0x291a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291a740>, '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': '41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648', '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 06:58:07 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 06:58:07 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 06:58:07 INFO - Using env: {'DISPLAY': ':0', 06:58:07 INFO - 'HOME': '/home/cltbld', 06:58:07 INFO - 'LANG': 'en_US.UTF-8', 06:58:07 INFO - 'LANGUAGE': 'en_US:en', 06:58:07 INFO - 'LOGNAME': 'cltbld', 06:58:07 INFO - 'MAIL': '/var/mail/cltbld', 06:58:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:07 INFO - 'MOZ_NO_REMOTE': '1', 06:58:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:07 INFO - 'NO_EM_RESTART': '1', 06:58:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:07 INFO - 'PWD': '/builds/slave/test', 06:58:07 INFO - 'SHELL': '/bin/bash', 06:58:07 INFO - 'SHLVL': '1', 06:58:07 INFO - 'TERM': 'linux', 06:58:07 INFO - 'TMOUT': '86400', 06:58:07 INFO - 'USER': 'cltbld', 06:58:07 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648', 06:58:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:07 INFO - '_': '/tools/buildbot/bin/python'} 06:58:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:58:07 INFO - Running setup.py (path:/tmp/pip-gXnKOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:58:08 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)) 06:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:58:08 INFO - Running setup.py (path:/tmp/pip-F06O7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:58:08 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)) 06:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:58:08 INFO - Running setup.py (path:/tmp/pip-NDLzMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:58:08 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)) 06:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:58:08 INFO - Running setup.py (path:/tmp/pip-MRyiai-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:58:08 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)) 06:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:58:08 INFO - Running setup.py (path:/tmp/pip-NjlrxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:58:08 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)) 06:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:58:08 INFO - Running setup.py (path:/tmp/pip-qYM7AY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:58:08 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)) 06:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:58:08 INFO - Running setup.py (path:/tmp/pip-nzBBNM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:58:08 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)) 06:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:58:08 INFO - Running setup.py (path:/tmp/pip-27u9pG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:58:08 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)) 06:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:58:08 INFO - Running setup.py (path:/tmp/pip-q6FBOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:58:08 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)) 06:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:58:08 INFO - Running setup.py (path:/tmp/pip-5NcmD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:58:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 06:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:58:08 INFO - Running setup.py (path:/tmp/pip-BDqcA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:58:08 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)) 06:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:58:08 INFO - Running setup.py (path:/tmp/pip-2uQKCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:58:08 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)) 06:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:58:08 INFO - Running setup.py (path:/tmp/pip-UqfhwT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:58:08 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)) 06:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:58:08 INFO - Running setup.py (path:/tmp/pip-b2YGyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:58:09 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)) 06:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:09 INFO - Running setup.py (path:/tmp/pip-uaPgJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:58:09 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)) 06:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:58:09 INFO - Running setup.py (path:/tmp/pip-509pdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:58:09 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)) 06:58:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:58:09 INFO - Running setup.py (path:/tmp/pip-46HgSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:58:09 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)) 06:58:09 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)) 06:58:09 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)) 06:58:09 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)) 06:58:09 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)) 06:58:09 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)) 06:58:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58: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 06:58:11 INFO - Downloading blessings-1.6.tar.gz 06:58:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:58:11 INFO - Installing collected packages: blessings 06:58:11 INFO - Running setup.py install for blessings 06:58:11 INFO - Successfully installed blessings 06:58:11 INFO - Cleaning up... 06:58:11 INFO - Return code: 0 06:58:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:58:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:58:11 INFO - Reading from file tmpfile_stdout 06:58:11 INFO - Current package versions: 06:58:11 INFO - argparse == 1.2.1 06:58:11 INFO - blessings == 1.6 06:58:11 INFO - blobuploader == 1.2.4 06:58:11 INFO - docopt == 0.6.1 06:58:11 INFO - functools32 == 3.2.3-2 06:58:11 INFO - jsonschema == 2.5.1 06:58:11 INFO - manifestparser == 1.1 06:58:11 INFO - mozInstall == 1.12 06:58:11 INFO - mozcrash == 0.17 06:58:11 INFO - mozdebug == 0.1 06:58:11 INFO - mozdevice == 0.48 06:58:11 INFO - mozfile == 1.2 06:58:11 INFO - mozhttpd == 0.7 06:58:11 INFO - mozinfo == 0.9 06:58:11 INFO - mozleak == 0.1 06:58:11 INFO - mozlog == 3.2 06:58:11 INFO - moznetwork == 0.27 06:58:11 INFO - mozprocess == 0.23 06:58:11 INFO - mozprofile == 0.28 06:58:11 INFO - mozrunner == 6.12 06:58:11 INFO - mozscreenshot == 0.1 06:58:11 INFO - mozsystemmonitor == 0.3 06:58:11 INFO - moztest == 0.7 06:58:11 INFO - mozversion == 1.4 06:58:11 INFO - psutil == 3.1.1 06:58:11 INFO - requests == 1.2.3 06:58:11 INFO - wsgiref == 0.1.2 06:58:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:58: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58:11 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 0x265a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29193b0>, '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 0x291a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291a740>, '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': '41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648', '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 06:58:11 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 06:58:11 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 06:58:11 INFO - Using env: {'DISPLAY': ':0', 06:58:11 INFO - 'HOME': '/home/cltbld', 06:58:11 INFO - 'LANG': 'en_US.UTF-8', 06:58:11 INFO - 'LANGUAGE': 'en_US:en', 06:58:11 INFO - 'LOGNAME': 'cltbld', 06:58:11 INFO - 'MAIL': '/var/mail/cltbld', 06:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:11 INFO - 'MOZ_NO_REMOTE': '1', 06:58:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:11 INFO - 'NO_EM_RESTART': '1', 06:58:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:11 INFO - 'PWD': '/builds/slave/test', 06:58:11 INFO - 'SHELL': '/bin/bash', 06:58:11 INFO - 'SHLVL': '1', 06:58:11 INFO - 'TERM': 'linux', 06:58:11 INFO - 'TMOUT': '86400', 06:58:11 INFO - 'USER': 'cltbld', 06:58:11 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648', 06:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:11 INFO - '_': '/tools/buildbot/bin/python'} 06:58:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:11 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)) 06:58:11 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)) 06:58:11 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)) 06:58:11 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)) 06:58:11 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)) 06:58:11 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)) 06:58:11 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)) 06:58:11 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)) 06:58:11 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)) 06:58:11 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)) 06:58:11 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)) 06:58:11 INFO - Cleaning up... 06:58:11 INFO - Return code: 0 06:58:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:58: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:58:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:58:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:58: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x265a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27bd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29193b0>, '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 0x291a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291a740>, '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': '41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648', '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 06:58: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', 'jsonschema'] in /builds/slave/test/build 06:58: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 jsonschema 06:58:11 INFO - Using env: {'DISPLAY': ':0', 06:58:11 INFO - 'HOME': '/home/cltbld', 06:58:11 INFO - 'LANG': 'en_US.UTF-8', 06:58:11 INFO - 'LANGUAGE': 'en_US:en', 06:58:11 INFO - 'LOGNAME': 'cltbld', 06:58:11 INFO - 'MAIL': '/var/mail/cltbld', 06:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:11 INFO - 'MOZ_NO_REMOTE': '1', 06:58:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:11 INFO - 'NO_EM_RESTART': '1', 06:58:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:11 INFO - 'PWD': '/builds/slave/test', 06:58:11 INFO - 'SHELL': '/bin/bash', 06:58:11 INFO - 'SHLVL': '1', 06:58:11 INFO - 'TERM': 'linux', 06:58:11 INFO - 'TMOUT': '86400', 06:58:11 INFO - 'USER': 'cltbld', 06:58:11 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648', 06:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:11 INFO - '_': '/tools/buildbot/bin/python'} 06:58:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:58:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:58:12 INFO - Cleaning up... 06:58:12 INFO - Return code: 0 06:58:12 INFO - Running post-action listener: _resource_record_post_action 06:58:12 INFO - Running post-action listener: _start_resource_monitoring 06:58:12 INFO - Starting resource monitoring. 06:58:12 INFO - ##### 06:58:12 INFO - ##### Finished create-virtualenv step (success) 06:58:12 INFO - ##### 06:58:12 INFO - ##### 06:58:12 INFO - ##### Running install step. 06:58:12 INFO - ##### 06:58:12 INFO - Running pre-action listener: _resource_record_pre_action 06:58:12 INFO - Running main action method: install 06:58:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:58:12 INFO - Reading from file tmpfile_stdout 06:58:12 INFO - Detecting whether we're running mozinstall >=1.0... 06:58:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:58:12 INFO - Reading from file tmpfile_stdout 06:58:12 INFO - Output received: 06:58:12 INFO - Usage: mozinstall [options] installer 06:58:12 INFO - Options: 06:58:12 INFO - -h, --help show this help message and exit 06:58:12 INFO - -d DEST, --destination=DEST 06:58:12 INFO - Directory to install application into. [default: 06:58:12 INFO - "/builds/slave/test"] 06:58:12 INFO - --app=APP Application being installed. [default: firefox] 06:58:12 INFO - mkdir: /builds/slave/test/build/application 06:58:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 06:58:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 06:58:29 INFO - Reading from file tmpfile_stdout 06:58:29 INFO - Output received: 06:58:29 INFO - /builds/slave/test/build/application/firefox/firefox 06:58:29 INFO - Running post-action listener: _resource_record_post_action 06:58:29 INFO - ##### 06:58:29 INFO - ##### Finished install step (success) 06:58:29 INFO - ##### 06:58:29 INFO - ##### 06:58:29 INFO - ##### Running run-tests step. 06:58:29 INFO - ##### 06:58:29 INFO - Running pre-action listener: _resource_record_pre_action 06:58:29 INFO - Running main action method: run_tests 06:58:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:58:29 INFO - Python 2.7.3 06:58:29 INFO - Return code: 0 06:58:29 INFO - grabbing minidump binary from tooltool 06:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:58:29 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 0x29193b0>, '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 0x291a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x291a740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:58:29 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 06:58:29 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 06:58:29 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 06:58:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:58:29 INFO - Return code: 0 06:58:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:58:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:58:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:58:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:58:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:58:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:58:29 INFO - Using env: {'DISPLAY': ':0', 06:58:29 INFO - 'HOME': '/home/cltbld', 06:58:29 INFO - 'LANG': 'en_US.UTF-8', 06:58:29 INFO - 'LANGUAGE': 'en_US:en', 06:58:29 INFO - 'LOGNAME': 'cltbld', 06:58:29 INFO - 'MAIL': '/var/mail/cltbld', 06:58:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:58:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:58:29 INFO - 'MOZ_NO_REMOTE': '1', 06:58:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:58:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:58:29 INFO - 'NO_EM_RESTART': '1', 06:58:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:58:29 INFO - 'PWD': '/builds/slave/test', 06:58:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:58:29 INFO - 'SHELL': '/bin/bash', 06:58:29 INFO - 'SHLVL': '1', 06:58:29 INFO - 'TERM': 'linux', 06:58:29 INFO - 'TMOUT': '86400', 06:58:29 INFO - 'USER': 'cltbld', 06:58:29 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648', 06:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:58:29 INFO - '_': '/tools/buildbot/bin/python'} 06:58:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:58:29 INFO - mozversion application_buildid: 20160714033529 06:58:29 INFO - mozversion application_changeset: d868ba1645e6fbc6671c09f49f331ba4acae9ad6 06:58:29 INFO - mozversion application_display_name: Nightly 06:58:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:58:29 INFO - mozversion application_name: Firefox 06:58:29 INFO - mozversion application_remotingname: firefox 06:58:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:58:29 INFO - mozversion application_vendor: Mozilla 06:58:29 INFO - mozversion application_version: 50.0a1 06:58:29 INFO - mozversion platform_buildid: 20160714033529 06:58:29 INFO - mozversion platform_changeset: d868ba1645e6fbc6671c09f49f331ba4acae9ad6 06:58:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:58:29 INFO - mozversion platform_version: 50.0a1 06:58:29 INFO - using testdate: 1468504709 06:58:29 INFO - actual date: 1468504709 06:58:29 INFO - starting webserver on 'localhost:55715' 06:58:29 INFO - SUITE-START | Running 2 tests 06:58:29 INFO - TEST-START | dromaeo_css 06:58:29 INFO - operating with platform_type : linux_ 06:58:29 INFO - Initialising browser for dromaeo_css test... 06:58:29 INFO - TEST-INFO | started process 8643 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO5IxiX/profile http://localhost:55715/getInfo.html) 06:58:34 INFO - PROCESS | 8643 | __metrics Screen width/height:1600/1200 06:58:34 INFO - PROCESS | 8643 | colorDepth:24 06:58:34 INFO - PROCESS | 8643 | Browser inner width/height: 1024/697 06:58:34 INFO - PROCESS | 8643 | __metrics 06:58:35 ERROR - PROCESS | 8643 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 06:58:35 INFO - TEST-INFO | 8643: exit 0 06:58:35 INFO - Browser initialized. 06:58:35 INFO - Running cycle 1/1 for dromaeo_css test... 06:58:35 INFO - TEST-INFO | started process 8762 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpO5IxiX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:58:47 INFO - PROCESS | 8762 | RSS: Main: 167641088 06:58:47 INFO - PROCESS | 8762 | 06:59:37 INFO - PROCESS | 8762 | 1468504777265 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] 07:01:45 INFO - PROCESS | 8762 | Cycle 1(1): loaded http://localhost:55715/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55715/tests/dromaeo/cssquery-ext.html) 07:01:46 INFO - PROCESS | 8762 | RSS: Main: 170872832 07:01:46 INFO - PROCESS | 8762 | 07:04:48 INFO - PROCESS | 8762 | Cycle 1(1): loaded http://localhost:55715/tests/dromaeo/cssquery-ext.html (next: http://localhost:55715/tests/dromaeo/cssquery-jquery.html) 07:04:49 INFO - PROCESS | 8762 | RSS: Main: 166952960 07:04:49 INFO - PROCESS | 8762 | 07:07:51 INFO - PROCESS | 8762 | Cycle 1(1): loaded http://localhost:55715/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55715/tests/dromaeo/cssquery-mootools.html) 07:07:51 INFO - PROCESS | 8762 | RSS: Main: 170119168 07:07:51 INFO - PROCESS | 8762 | 07:10:53 INFO - PROCESS | 8762 | Cycle 1(1): loaded http://localhost:55715/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55715/tests/dromaeo/cssquery-prototype.html) 07:10:54 INFO - PROCESS | 8762 | RSS: Main: 166088704 07:10:54 INFO - PROCESS | 8762 | 07:13:56 INFO - PROCESS | 8762 | Cycle 1(1): loaded http://localhost:55715/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55715/tests/dromaeo/cssquery-yui.html) 07:13:57 INFO - PROCESS | 8762 | RSS: Main: 168480768 07:13:57 INFO - PROCESS | 8762 | 07:17:00 INFO - PROCESS | 8762 | Cycle 1(1): loaded http://localhost:55715/tests/dromaeo/cssquery-yui.html (next: http://localhost:55715/tests/dromaeo/cssquery-dojo.html) 07:17:00 INFO - PROCESS | 8762 | RSS: Main: 169230336 07:17:00 INFO - PROCESS | 8762 | 07:17:00 INFO - PROCESS | 8762 | __start_tp_report 07:17:00 INFO - PROCESS | 8762 | _x_x_mozilla_page_load 07:17:00 INFO - PROCESS | 8762 | _x_x_mozilla_page_load_details 07:17:00 INFO - PROCESS | 8762 | |i|pagename|runs| 07:17:00 INFO - PROCESS | 8762 | |0;dojo.html;3040.3463255400084;3106.7669924755637;3110.65782763896;3122.703343182397;3147.7009684080003;5475.67145971242;5483.287172667553;5542.972285138574;5569.777208911639;5581.2186293918785;5448.945510544893;5466.644668096581;5486;5544.390117087128;5609.691466969315;4775.172615707423;4874.853754387365;4937.481564435737;5068.265101560271;5187.351581052369;5096.210087436453;5115.9488405116035;5146.305248791421;5152.330197074375;5213.035588416136;4883.072216278913;4956.950430495703;4976.2784396262705;4979.053979743837;5025.120603894322;4936.851894443173;4961.355023846877;4973.4280557735965;4976.850694479172;4985.576226020793;4867.853964381075;4909.607231421478;4973.651844370896;4996.475370086125;5010.52400022001;5460.262864513319;5489.615726899118;5498.477644623795;5552.333719953591;5580.804671836466;5884.499817515473;5897.203877476529;5912.142739302777;5912.290525136968;5930.584859059867;5715.857103572403;5916.497097746696;5958.880822383528;5999.040153575451;6002.909956350614;5508.421615730371;5563.165525171256;5569.359523654791;5627.521660658849;5676.233708449347;6035.969820150871;6059.8485037873525;6099.603525770899;6099.9085013724825;6137.478314343241;5704.686242256633;5793.507551858055;5830.591858569945;5881.676507792027;5893.705314734246;5943.197668314722;5950.642961422329;5970.910436343458;5975.492083172892;6014.218151640259;5664.68844213564;5779.682117483579;5824;5878.206442130343;5943.673097979653;5696.544276457957;5822.214001109796;5866.1494083357675;5918.437748413894;5933.139694744238;4490.461144662596;4512.323151527297;4512.909741805145;4564.452265728134;4570.840020599263;3967.6032396760093;4008.6592639625374;4012.25773231953;4015.357542793139;4040.5353384360587;5500.972495137498;5552.555795536347;5595.944040559623;5694.97152514243;5750.597458177971;5884.882302353929;5891.882162356729;5902.940970590239;5903.114532820111;5904.881902361929;5635.577331700057;5636.577256705764;5651;5669.518090962232;5675.1487276907965;4966.609349382179;5045.495450454925;5059.595232381401;5086.160783470686;5095.694258344512;6094.481969032593;6138.07928810673;6148.1085242639565;6149.108379284979;6161.537884658668;5982.850428739316;5988.041913293852;5988.311344195299;5988.431099045583;5990.221271234712;6003.219581454383;6090.908636370546;6106.15732346443;6118.479929206067;6180.721867515883;5882.970585147047;5892.823215303548;5893.469587737124;5893.616914900518;5934.554908381802;5800.477956983892;5935.0503919372695;5942.286925568959;5993.730282137227;6005.939940600538;5604;5771.653700777967;5787.247657804459;5826.621269617462;5859;5625.268715067015;5733.5126514245085;5753.108268218432;5754.7122643866805;5757.165211044459;5733.369329373682;5777.7977770777825;5788.479036886701;5796.275465566804;5830.737616807169;5803.593748437737;5815.592908496534;5871.911921321098;5900.586958912835;5948.702564871653;5548.944510555004;5601.663900166003;5625.690587017753;5663.008973429715;5803.303603567599 07:17:00 INFO - PROCESS | 8762 | |1;ext.html;547.9452054794522;589.3605438099662;601.8856417280717;602.1569802276812;629.7638385605399;38884;43184;43330;43395.78302108489;43431;42730.78634606823;43310.35034474485;43328.78335608325;43337.56662433375;43367.783161084226;8794.560271986391;8896.154865287788;8956.238719708832;8963.910360896372;8982.19160275575;8803.20771130598;8847.955760221223;8906.153915378061;8927.06265842087;8932.776680582972;8715.651373945066;8739.650413983465;8741.388102832805;8749.431286966359;8766;8872.556372181398;8886.911130888706;8905.688300909469;8918.10818918103;8949.59726812295;8713.956430217871;8842.734717958407;8867.246284065863;8873.73378798637;8883.911160888372;41500.37749433761;41551;41644.167116657496;41996.37005444921;42032.57967420348;3385.407553678121;3403.795772253648;3443.6728510791436;3492.0746002309406;3509.6841284284283;32527.837360813282;32782.50826237608;33004.83497582521;33111.14756216974;33791;4463.4866990296205;4485.461744590637;4501.617362524189;4521;4642.3500709900645;376905;378598;379474;380018;380625;31783.682163178073;32780.836095819366;57394.7130264346;57494.42505574974;57538.424615753305;35232.823835880656;35519.82240088783;35521.46717799235;35684.107897302776;35702.10744731351;15043.323050462755;15182.772258416133;15184.620384490476;15199.848001520064;15269;12445.37773111359;12465.626031219077;12469.127161098637;12506.562270320495;12528.123031387715;8225.259726624632;8256;8260;8269.46248493846;8359.122292159358;3173.4129186100186;3175.71418572325;3209;3216.292415668549;3262.869485220612;1021.97445063874;1033.6640591807693;1115.6374178391893;1123.084685980923;1124.651358078998;32992.67007329944;33262.833685831414;33269.3346133076;33638.831805841306;33979.49030764541;1094.4035500652165;1118.6532175025768;1127.774445110981;1146.3351256271342;1202.3627477436971;17347.479575612753;17594.64810703779;17623.38318158884;17669.38157164493;17729.911350443424;605858;610188;615977;617441;619396;59356.70321648451;59604.70197648984;59884.401155987885;59953;60008.699956499935;1338.645259006364;1376.9793453098412;1379.6412932637586;1382.9446822127204;1390.4299237312653;31699.36601268008;32696;32763.836180818944;33031.50452743163;33137;52179;52444.21333680074;52873;52937.20594191167;53033.46966530285;464596;465292;466454;466575;467707;27945;27982;28086.157415277576;28536.85731571329;28648.14055578336;48321.27518087302;49567.75216123896;49807.252891205935;50107.74946125246;50338.244926326865;43020.35469468023;43033.784831075645;43165;43189.352159718255;44326.55673443224;43116.00541861931;43293.86362398377;43458;43613.34579981239;44092.55907441013;36627.45058824067;40310;41034.58965410427;41780.58219417888;42979;36658.45012324871;38683.80658096691;39125.6087439122;39301;39760.80119599384;29282;29384;29411.705882940896;29471;29530.704692953655 07:17:00 INFO - PROCESS | 8762 | |2;jquery.html;382.4585628498626;382.7760759955426;386.64815018333303;397.59246772058657;401.4259608759473;17865.464036078924;18757.531061723428;20455.59088818223;20492.385228443152;20518.487037824063;12122.636320910366;12549.176435302052;12666.49334026638;12691.365431728424;19294.517637059045;5200.557952574026;5330.227117068022;5332.733363331838;5344.4922732340365;5367.221752845835;3828.119532507511;5144.279800827887;6350.523710721691;6524.217093948709;6606.075149479077;6488.25385080717;6504.804855854332;6506.674666266667;6550.508711846607;6562.015697645344;5989;6319.6524191169465;6333.683315834213;6357.364263573606;6395.16862807832;5530.5852061095575;5801.564882633819;5818.41815818419;5828.5628577856405;5843.240378750777;12234.877651223553;12371.505139794397;12383.257004579664;20904.163833446644;22326.776732232633;2314.7963059209287;2516.8615726135054;2573.4853029394008;2655.2830735701255;2995.8352290624007;9735;9878.753031174207;10275.588976440933;10433.426161561187;10685.626003089932;1878.229925730444;1969.6257711035;1975.1210711233507;1996.7104769808298;2048.805363490466;87830.56084719536;90638;91119.08880911239;91777;92137.61793573102;11117.833232501518;11165.720856978478;11247.775044499063;11248.887511124783;11377;15747.68504629901;15765.448209312848;15917.761233581505;15933.760993585105;15948.2823272953;8238.629261683238;8288.751337459886;8426.368022398345;8459.661613535389;8467.449615774955;7863.567503787232;7917.7624671259955;7918.670445456085;7922.485038472596;8058.3150432213915;4606.286025665961;4704.694194877322;4758.833440829623;4855.198892182821;4873.342098816685;1981.564055907698;1996.0319245166083;2003.3589251439691;2006.9698954515693;2038.2967876082728;1042.7497400623947;1051.4427353502656;1066.7173199102244;1073.6993641780314;1076.7308172956762;19698;19742.90128549377;19916.103775330146;19953.60092798136;19975.300864469675;964.238251781099;971.0920289529172;976.6093562575027;999.1507218864053;1028.3521381529588;10630.787384252271;11052.281601695864;11054.668359949215;11083.667489975314;11104.555817767361;496619;513682;533651;544898;547192.64036798;79342;84031.5798421004;89433.55283223672;97503;98202;989.8267803134422;1017.4048181813574;1018.3533456255183;1018.5671089786811;1021.2748948246827;15290.923545382648;17522.211500482765;17616.29534818593;18319.816801832345;18420.447386578424;41520.377194341505;42009.78995105005;42448.36327455152;42803.357949631405;44700.10599788051;60187.39812601818;61370;61926.69036654788;62132;62566.687166563876;8418.116097809641;8653.091425400495;8691.652333906573;8874.60064297121;8984.326175536991;11742.236754610924;12813.551525696555;12834.037447191311;12985.545505907248;13077.411516481972;10458;10579.62971296001;10600.787984240118;10823.080038196842;10948.124150068135;10843.891561084603;11082.279651822606;11260.7747845041;11288.322700637988;11434.142439316918;9932.205423565953;9962.053604907522;10616.363018218623;10630.627928022483;10886.836697449386;8443.408961372645;8535.189157030072;8727.91272087271;8746.69386571467;8862.335324850534;10051.597936082475;10241.692749217535;10485.68542943713;10545.36727796304;10560.683179504627 07:17:00 INFO - PROCESS | 8762 | |3;mootools.html;1449.5289031064904;1474.3586539855164;1597.4967885116187;1760.8503277221434;1778.0754007915884;7468.701251949916;8554.700585479502;8599.183077607633;9157.221636160926;9190.908090919089;8592.957035214831;8825.646974121028;8948.776280592972;8950.507722075283;8967.372283940127;2351.976480235193;2357.2221167014845;2390.497995420964;2391.5097405031925;2394.724606670229;2338.543983923136;2340.4850932794757;2351.1183306260154;2358.127492827656;2364.869932153731;2336.4976530046038;2338.2166974063625;2342.1919437793936;2360.468894498741;2401.3396316013063;2317.4206448387904;2328.906843726249;2330.5338932213626;2331.918382856592;2380.25022118034;2322.500662357584;2324.233003108987;2337.322176568793;2337.6844126043106;2342.203650758733;8792.824143517159;8901.510416927067;9008.099190081006;9021.954890225572;9063.184313411824;5387.4612538746205;5450.972745136249;5489.533389661883;5496.5053145217125;5516.062269414169;3497.178163131662;3507.4037413639744;3516.7010804081683;3545.468179773029;3550.7336949728615;1156.9652910412701;1167.357953125786;1222.944967476457;1226.4542278685988;1245.1346314311556;12266.325352105541;12405.131640785148;12433.191842530297;12445.502179912794;12450.564230251988;4738.691985020962;4772.641114148305;4830.850271629091;4857.9028419431415;4956.3804524434445;10810.189235807346;10843.945780271048;10867.673969780919;10884.346939183675;10926.617568385069;5516.117421212587;5523.613347065667;5525.254090697785;5532.336119665585;5533.695646739468;4124.422580838685;4926.605871530269;5081.923771143436;5084.872878178076;5096.133657278272;4064.1058967027207;4096.669906186141;4103.528094269138;4138.875833724993;4154.5222299435345;1205.7829590673587;1307.5096838685492;1313.343328335832;1315.4475120449433;1341.93961271743;870.9695160669346;906.5014242166782;965.3146266150972;973.464594473037;1028.9485525723685;6031.09533569968;6144.723487443076;6184.536159788034;6197.96901015492;6378.457831084317;972.4845831709206;988.19462138357;999.430893497217;1018.6434747838198;1027.3168343051937;4173.812178451977;4354.825806967686;4388.846390376321;4400.9559904401185;4453.599176074104;11082.390468524147;11412.657620271406;11435.428228588537;11455.198136130557;11561.248518846249;11403;11412.372319522507;11424.257423267627;11448.885511144948;11456.541738330374;7882.172371900982;8183.386246031571;8184.427090103635;8474.1949514796;8628.266597339296;6365.90451143224;6720.865582688417;6735.730570777114;6737.69680364375;6749.426298764463;10361.689149325532;10398.324108932895;10457.529411176667;10514.106300964504;10526.368417894952;10346.482675866026;10461.215408844215;10688.465576721288;10816.242862999514;10833.02502774754;6922.134733158356;7346.6326683666675;7585.772426827204;7990.240927111915;8116.188381161836;8567.057623661267;8590.055093939536;8613.353998450266;8650.307975362082;8710.47737135774;7695.615219238904;7894.171112033154;7966.482178658369;7971.601419929097;7988.880166797387;7706.7687969361;7755.379569634303;7772.339351154989;7851.921480785348;7856.7250146244605;7120.430365570845;7165.104361954755;7184.9640751798;7218.3036986307125;7228.060352154186;4927.137750893651;5169.689818610896;5198.610104242272;5291.682499050069;5305.734713264398;4926.113299606105;5009.3487846581165;5030.647854650139;5063.873403164803;5098.464661210668 07:17:00 INFO - PROCESS | 8762 | |4;prototype.html;318.2965645922511;332.55935884952436;333.2584998378607;335.1888429999401;337.86654271562736;5533.418991005942;5628.8592785180335;5677.545796336293;5699.373068962411;5742.497076783159;5567.805126820562;5577.079781836002;5577.832665020046;5579.38626751057;5586.944130558693;4368;4369.541198174194;4376.715513491628;4378.562143785628;4382.9342559861625;4247.851325203618;4312.2453570625175;4342.370356298351;4363.214621368153;4403.295472724365;4277.438734861768;4308.612224899758;4315.978420107911;4316.84891028814;4324.805383757723;4325.156594464081;4335.848245311399;4341.5441378655105;4354.978225108885;4367.192069467159;3552.946705799415;3760.567534733513;3851.4607954886337;3854.614538546151;3857.8263978121054;5468.91796623051;5477.178423236506;5479.369872464637;5481.643693159932;5503.394626591072;4908.828191013333;4942.604591632661;4946.653734238605;4961.3798275215595;4989.954118811306;5590.049691552445;5776.855578610526;5816.2260510544265;5847.298324201123;5871.735771890275;4109.630133288018;4113.642497975661;4114.753114813121;4137.275976704064;4137.731047481904;5853.795117170921;5897.882042359129;6067.484263837579;6089.695515224265;6100.72546735398;4170.374443833389;4184.832606695759;4185.309423945076;4186.539480657125;4193.811278492475;4253.63844073251;4272.401863739079;4280.459034747489;4285.250081235771;4285.885669725832;4663.253879379351;4927.95072049282;4928.186849169919;4946.1344264753525;4950.18321976877;5877.617954832922;5880.441358070976;5893.528517718572;5896.823095307148;5903.616264942765;1456.5411895252962;1468.5227301127177;1472.8674419302315;1477;1478.6746915678534;904.202022353344;938.5635679409107;938.671464987249;942.2885721280527;942.3921570586933;5046.855086588185;5055.51972562606;5064.518870707277;5071.492850714899;5095.26118712792;5267.656747529432;5341.009034940445;5352.464753524617;5360.46209501727;5368.8389348319615;5069.188929771292;5069.239614057921;5121.231815227746;5356.4107948125675;5797.971010145006;3170.2708377073404;3214.9678503215137;3219.114743445571;3238.498032804919;3241.6434192238835;6147.477464415485;6241.313455519889;6249.406306400884;6260.561760676709;6337.904931426032;6148.815535533941;6184.196054512884;6189.102580125857;6223.253209614875;6230.59501132425;6198.690065496708;6230.439260466489;6231.597890474607;6240.126382306481;6266.49868010558;5787.508061814793;6034.879302414015;6062.302835174011;6062.514998800174;6072.392760724069;5985.65322802366;5987.580869339278;6018.789342372996;6022.668753218615;6025.548083893638;5941.257342832146;6075.2405949256345;6218.875622487615;6243.250809902841;6267.62394256346;4266.807993640356;4267.210566045292;4291.914161716811;4293.205756934977;4323.2650449423045;5838.241028666416;5991.584796665858;6006.339302676614;6006.909896351471;6029.161105862754;5805.245318108618;5807.82576522705;5847.152162936265;5858.736356864037;5922.911156332744;5793.652380857162;5851.180834683233;5856.443637854397;5867.559933004956;5888.116782482662;5584.609077364546;5688.886222275614;5763.7406316715005;5790.26292112373;5794.565407594363;5755.5971082025535;5819.79630712923;5875.236219291465;5876.735546900314;5881.647101173943;5489.505944465017;5701.515371193495;5714.457096583982;5763.394843541536;5812.651240925558 07:17:00 INFO - PROCESS | 8762 | |5;yui.html;599.8961910085443;642.2870613618885;644.2558844534565;656.3075954867613;663.8108139180334;13184.143030702997;13462.5288114916;14956.177410242446;15230.314635841387;15350.846491535109;15733.921330393332;15783.368665253376;15804.762928556082;15838;15855.3657853686;782.2216894190288;788.4874831359633;804.9839003219932;819.5410570080744;828.5732847583499;815.1522416686669;815.3762371785589;816.7019038051099;818.071488860142;820.9014918209793;846.2468403121227;847.1401527449643;847.7499137754346;848.3594885861166;849.6389034660275;842.8567143585544;843.1652663862762;843.4264700003995;843.6751850537526;844.3793811548506;613.5030625193563;615.8645098078416;616;616.8057062025448;616.8735409241095;15170.31733571992;15305.387784488606;15314.846851531565;15321.310541025681;15347.155906425141;14346.856531434762;14425.639359016004;14475;14503.492377766728;14508.347124379428;11387.316760994285;11455.484503197376;11532.077433805276;11546.076313894951;11699.941500292443;3793.1275806564645;3816.084139806454;3915.451836742858;3993.341098718737;3994.320965435854;82240.58879705564;82498.58750706268;85500;85951.57024214839;86661;10496.370217786805;10800.405977671304;10836.467050144292;10845.728856778644;10917.563297468012;20787.272445464336;20908.58182836335;21005.36983890486;21008.054637541347;21024.369268921957;7498.025256716701;7721.112072111779;8279.047909490366;8303.750887473385;8398.41211115216;4513.323001549728;4548.809057994365;4623.722576645412;4666.393368862026;4745.644076694192;3343.8996830095134;3458.7405944554257;3463.3765922134257;3464.064702530303;3466.5146879436898;593.4006653280218;605.4187979539691;614.6895817612077;618.5793660311032;627.97802076928;558.3160628230386;578.8094198006403;602.430668109577;660.0561197487639;672.7140965089817;9146.451212927246;9290.334162797782;9353.204977576983;9383.906160938302;9479.905200947902;658.5620562326095;680.8025672554903;682.2972338491362;686.1286166568431;695.9967739205313;4429.446319210098;4440.777961101997;4481.1933851906315;4509.413776209138;4587.082583483317;112364.43817780858;115469.42265288619;116427.41786291014;120847;121163.39418302852;59366.703166483894;62156.06765898515;89432;102413;102667.48666256771;78048;82052.58973705213;82962;84326;87588.56205718931;8453.661853526037;8485.109063548485;8530.914690853013;8592.140785921358;8624.870626940476;53259.73370133124;53515.464845351045;54114;54192.45807541874;56291.71854140703;68416.6579167101;77977.61011194908;78617;78864.60567697124;79116;11285;11355.205135640426;11649.88350116488;11729.765404692029;11813.291202527877;13552.457901683822;13689.657758556115;13704.040717150103;13779.862201377859;14561.92719036398;11569.132315076235;11629.883701163219;11659.892310230514;11871.109666775199;12195.268283902995;11928.224665396721;12042.879571204176;12230;12324.876751232372;12641.2415255085;11369.658910232707;11454.599089031844;11626.476808543466;11642.221902574842;11670.241434306743;10276.280660353703;10324.174066074545;10531.21015923824;10748.140148788234;10766.838497422701;10143.543540540546;10381.273310868166;10399.428031458343;10500.894991049992;10517.737056573647 07:17:00 INFO - PROCESS | 8762 | __end_tp_report 07:17:00 INFO - PROCESS | 8762 | __start_cc_report 07:17:00 INFO - PROCESS | 8762 | _x_x_mozilla_cycle_collect,364 07:17:00 INFO - PROCESS | 8762 | __end_cc_report 07:17:00 INFO - PROCESS | 8762 | __startTimestamp1468505820383__endTimestamp 07:17:00 INFO - PROCESS | 8762 | 07:17:00 INFO - PROCESS | 8762 | ------- Summary: start ------- 07:17:00 INFO - PROCESS | 8762 | Number of tests: 6 07:17:00 INFO - PROCESS | 8762 | 07:17:00 INFO - PROCESS | 8762 | [#0] dojo.html Cycles:165 Average:5491.97 Median:5704.69 stddev:645.06 (11.3%) stddev-sans-first:617.70 07:17:00 INFO - PROCESS | 8762 | Values: 3040.3 3106.8 3110.7 3122.7 3147.7 5475.7 5483.3 5543.0 5569.8 5581.2 5448.9 5466.6 5486.0 5544.4 5609.7 4775.2 4874.9 4937.5 5068.3 5187.4 5096.2 5115.9 5146.3 5152.3 5213.0 4883.1 4957.0 4976.3 4979.1 5025.1 4936.9 4961.4 4973.4 4976.9 4985.6 4867.9 4909.6 4973.7 4996.5 5010.5 5460.3 5489.6 5498.5 5552.3 5580.8 5884.5 5897.2 5912.1 5912.3 5930.6 5715.9 5916.5 5958.9 5999.0 6002.9 5508.4 5563.2 5569.4 5627.5 5676.2 6036.0 6059.8 6099.6 6099.9 6137.5 5704.7 5793.5 5830.6 5881.7 5893.7 5943.2 5950.6 5970.9 5975.5 6014.2 5664.7 5779.7 5824.0 5878.2 5943.7 5696.5 5822.2 5866.1 5918.4 5933.1 4490.5 4512.3 4512.9 4564.5 4570.8 3967.6 4008.7 4012.3 4015.4 4040.5 5501.0 5552.6 5595.9 5695.0 5750.6 5884.9 5891.9 5902.9 5903.1 5904.9 5635.6 5636.6 5651.0 5669.5 5675.1 4966.6 5045.5 5059.6 5086.2 5095.7 6094.5 6138.1 6148.1 6149.1 6161.5 5982.9 5988.0 5988.3 5988.4 5990.2 6003.2 6090.9 6106.2 6118.5 6180.7 5883.0 5892.8 5893.5 5893.6 5934.6 5800.5 5935.1 5942.3 5993.7 6005.9 5604.0 5771.7 5787.2 5826.6 5859.0 5625.3 5733.5 5753.1 5754.7 5757.2 5733.4 5777.8 5788.5 5796.3 5830.7 5803.6 5815.6 5871.9 5900.6 5948.7 5548.9 5601.7 5625.7 5663.0 5803.3 07:17:00 INFO - PROCESS | 8762 | 07:17:00 INFO - PROCESS | 8762 | [#1] ext.html Cycles:180 Average:62986.85 Median:42014.47 stddev:132222.06 (314.7%) stddev-sans-first:132509.87 07:17:00 INFO - PROCESS | 8762 | Values: 547.9 589.4 601.9 602.2 629.8 38884.0 43184.0 43330.0 43395.8 43431.0 42730.8 43310.4 43328.8 43337.6 43367.8 8794.6 8896.2 8956.2 8963.9 8982.2 8803.2 8848.0 8906.2 8927.1 8932.8 8715.7 8739.7 8741.4 8749.4 8766.0 8872.6 8886.9 8905.7 8918.1 8949.6 8714.0 8842.7 8867.2 8873.7 8883.9 41500.4 41551.0 41644.2 41996.4 42032.6 3385.4 3403.8 3443.7 3492.1 3509.7 32527.8 32782.5 33004.8 33111.1 33791.0 4463.5 4485.5 4501.6 4521.0 4642.4 376905.0 378598.0 379474.0 380018.0 380625.0 31783.7 32780.8 57394.7 57494.4 57538.4 35232.8 35519.8 35521.5 35684.1 35702.1 15043.3 15182.8 15184.6 15199.8 15269.0 12445.4 12465.6 12469.1 12506.6 12528.1 8225.3 8256.0 8260.0 8269.5 8359.1 3173.4 3175.7 3209.0 3216.3 3262.9 1022.0 1033.7 1115.6 1123.1 1124.7 32992.7 33262.8 33269.3 33638.8 33979.5 1094.4 1118.7 1127.8 1146.3 1202.4 17347.5 17594.6 17623.4 17669.4 17729.9 605858.0 610188.0 615977.0 617441.0 619396.0 59356.7 59604.7 59884.4 59953.0 60008.7 1338.6 1377.0 1379.6 1382.9 1390.4 31699.4 32696.0 32763.8 33031.5 33137.0 52179.0 52444.2 52873.0 52937.2 53033.5 464596.0 465292.0 466454.0 466575.0 467707.0 27945.0 27982.0 28086.2 28536.9 28648.1 48321.3 49567.8 49807.3 50107.7 50338.2 43020.4 43033.8 43165.0 43189.4 44326.6 43116.0 43293.9 43458.0 43613.3 44092.6 36627.5 40310.0 41034.6 41780.6 42979.0 36658.5 38683.8 39125.6 39301.0 39760.8 29282.0 29384.0 29411.7 29471.0 29530.7 07:17:00 INFO - PROCESS | 8762 | 07:17:00 INFO - PROCESS | 8762 | [#2] jquery.html Cycles:180 Average:30012.64 Median:1689.15 stddev:87026.44 (5152.1%) stddev-sans-first:87242.13 07:17:00 INFO - PROCESS | 8762 | Values: 382.5 382.8 386.6 397.6 401.4 17865.5 18757.5 20455.6 20492.4 20518.5 12122.6 12549.2 12666.5 12691.4 19294.5 5200.6 5330.2 5332.7 5344.5 5367.2 3828.1 5144.3 6350.5 6524.2 6606.1 6488.3 6504.8 6506.7 6550.5 6562.0 5989.0 6319.7 6333.7 6357.4 6395.2 5530.6 5801.6 5818.4 5828.6 5843.2 12234.9 12371.5 12383.3 20904.2 22326.8 2314.8 2516.9 2573.5 2655.3 2995.8 9735.0 9878.8 10275.6 10433.4 10685.6 1878.2 1969.6 1975.1 1996.7 2048.8 87830.6 90638.0 91119.1 91777.0 92137.6 11117.8 11165.7 11247.8 11248.9 11377.0 15747.7 15765.4 15917.8 15933.8 15948.3 8238.6 8288.8 8426.4 8459.7 8467.4 7863.6 7917.8 7918.7 7922.5 8058.3 4606.3 4704.7 4758.8 4855.2 4873.3 1981.6 1996.0 2003.4 2007.0 2038.3 1042.7 1051.4 1066.7 1073.7 1076.7 19698.0 19742.9 19916.1 19953.6 19975.3 964.2 971.1 976.6 999.2 1028.4 10630.8 11052.3 11054.7 11083.7 11104.6 496619.0 513682.0 533651.0 544898.0 547192.6 79342.0 84031.6 89433.6 97503.0 98202.0 989.8 1017.4 1018.4 1018.6 1021.3 15290.9 17522.2 17616.3 18319.8 18420.4 41520.4 42009.8 42448.4 42803.4 44700.1 60187.4 61370.0 61926.7 62132.0 62566.7 8418.1 8653.1 8691.7 8874.6 8984.3 11742.2 12813.6 12834.0 12985.5 13077.4 10458.0 10579.6 10600.8 10823.1 10948.1 10843.9 11082.3 11260.8 11288.3 11434.1 9932.2 9962.1 10616.4 10630.6 10886.8 8443.4 8535.2 8727.9 8746.7 8862.3 10051.6 10241.7 10485.7 10545.4 10560.7 07:17:00 INFO - PROCESS | 8762 | 07:17:00 INFO - PROCESS | 8762 | [#3] mootools.html Cycles:180 Average:5957.98 Median:4801.75 stddev:3388.02 (70.6%) stddev-sans-first:3380.59 07:17:00 INFO - PROCESS | 8762 | Values: 1449.5 1474.4 1597.5 1760.9 1778.1 7468.7 8554.7 8599.2 9157.2 9190.9 8593.0 8825.6 8948.8 8950.5 8967.4 2352.0 2357.2 2390.5 2391.5 2394.7 2338.5 2340.5 2351.1 2358.1 2364.9 2336.5 2338.2 2342.2 2360.5 2401.3 2317.4 2328.9 2330.5 2331.9 2380.3 2322.5 2324.2 2337.3 2337.7 2342.2 8792.8 8901.5 9008.1 9022.0 9063.2 5387.5 5451.0 5489.5 5496.5 5516.1 3497.2 3507.4 3516.7 3545.5 3550.7 1157.0 1167.4 1222.9 1226.5 1245.1 12266.3 12405.1 12433.2 12445.5 12450.6 4738.7 4772.6 4830.9 4857.9 4956.4 10810.2 10843.9 10867.7 10884.3 10926.6 5516.1 5523.6 5525.3 5532.3 5533.7 4124.4 4926.6 5081.9 5084.9 5096.1 4064.1 4096.7 4103.5 4138.9 4154.5 1205.8 1307.5 1313.3 1315.4 1341.9 871.0 906.5 965.3 973.5 1028.9 6031.1 6144.7 6184.5 6198.0 6378.5 972.5 988.2 999.4 1018.6 1027.3 4173.8 4354.8 4388.8 4401.0 4453.6 11082.4 11412.7 11435.4 11455.2 11561.2 11403.0 11412.4 11424.3 11448.9 11456.5 7882.2 8183.4 8184.4 8474.2 8628.3 6365.9 6720.9 6735.7 6737.7 6749.4 10361.7 10398.3 10457.5 10514.1 10526.4 10346.5 10461.2 10688.5 10816.2 10833.0 6922.1 7346.6 7585.8 7990.2 8116.2 8567.1 8590.1 8613.4 8650.3 8710.5 7695.6 7894.2 7966.5 7971.6 7988.9 7706.8 7755.4 7772.3 7851.9 7856.7 7120.4 7165.1 7185.0 7218.3 7228.1 4927.1 5169.7 5198.6 5291.7 5305.7 4926.1 5009.3 5030.6 5063.9 5098.5 07:17:00 INFO - PROCESS | 8762 | 07:17:00 INFO - PROCESS | 8762 | [#4] prototype.html Cycles:180 Average:4879.02 Median:5550.61 stddev:1446.71 (26.1%) stddev-sans-first:1409.69 07:17:00 INFO - PROCESS | 8762 | Values: 318.3 332.6 333.3 335.2 337.9 5533.4 5628.9 5677.5 5699.4 5742.5 5567.8 5577.1 5577.8 5579.4 5586.9 4368.0 4369.5 4376.7 4378.6 4382.9 4247.9 4312.2 4342.4 4363.2 4403.3 4277.4 4308.6 4316.0 4316.8 4324.8 4325.2 4335.8 4341.5 4355.0 4367.2 3552.9 3760.6 3851.5 3854.6 3857.8 5468.9 5477.2 5479.4 5481.6 5503.4 4908.8 4942.6 4946.7 4961.4 4990.0 5590.0 5776.9 5816.2 5847.3 5871.7 4109.6 4113.6 4114.8 4137.3 4137.7 5853.8 5897.9 6067.5 6089.7 6100.7 4170.4 4184.8 4185.3 4186.5 4193.8 4253.6 4272.4 4280.5 4285.3 4285.9 4663.3 4928.0 4928.2 4946.1 4950.2 5877.6 5880.4 5893.5 5896.8 5903.6 1456.5 1468.5 1472.9 1477.0 1478.7 904.2 938.6 938.7 942.3 942.4 5046.9 5055.5 5064.5 5071.5 5095.3 5267.7 5341.0 5352.5 5360.5 5368.8 5069.2 5069.2 5121.2 5356.4 5798.0 3170.3 3215.0 3219.1 3238.5 3241.6 6147.5 6241.3 6249.4 6260.6 6337.9 6148.8 6184.2 6189.1 6223.3 6230.6 6198.7 6230.4 6231.6 6240.1 6266.5 5787.5 6034.9 6062.3 6062.5 6072.4 5985.7 5987.6 6018.8 6022.7 6025.5 5941.3 6075.2 6218.9 6243.3 6267.6 4266.8 4267.2 4291.9 4293.2 4323.3 5838.2 5991.6 6006.3 6006.9 6029.2 5805.2 5807.8 5847.2 5858.7 5922.9 5793.7 5851.2 5856.4 5867.6 5888.1 5584.6 5688.9 5763.7 5790.3 5794.6 5755.6 5819.8 5875.2 5876.7 5881.6 5489.5 5701.5 5714.5 5763.4 5812.7 07:17:00 INFO - PROCESS | 8762 | 07:17:00 INFO - PROCESS | 8762 | [#5] yui.html Cycles:180 Average:20357.89 Median:4511.37 stddev:29832.78 (661.3%) stddev-sans-first:29879.59 07:17:00 INFO - PROCESS | 8762 | Values: 599.9 642.3 644.3 656.3 663.8 13184.1 13462.5 14956.2 15230.3 15350.8 15733.9 15783.4 15804.8 15838.0 15855.4 782.2 788.5 805.0 819.5 828.6 815.2 815.4 816.7 818.1 820.9 846.2 847.1 847.7 848.4 849.6 842.9 843.2 843.4 843.7 844.4 613.5 615.9 616.0 616.8 616.9 15170.3 15305.4 15314.8 15321.3 15347.2 14346.9 14425.6 14475.0 14503.5 14508.3 11387.3 11455.5 11532.1 11546.1 11699.9 3793.1 3816.1 3915.5 3993.3 3994.3 82240.6 82498.6 85500.0 85951.6 86661.0 10496.4 10800.4 10836.5 10845.7 10917.6 20787.3 20908.6 21005.4 21008.1 21024.4 7498.0 7721.1 8279.0 8303.8 8398.4 4513.3 4548.8 4623.7 4666.4 4745.6 3343.9 3458.7 3463.4 3464.1 3466.5 593.4 605.4 614.7 618.6 628.0 558.3 578.8 602.4 660.1 672.7 9146.5 9290.3 9353.2 9383.9 9479.9 658.6 680.8 682.3 686.1 696.0 4429.4 4440.8 4481.2 4509.4 4587.1 112364.4 115469.4 116427.4 120847.0 121163.4 59366.7 62156.1 89432.0 102413.0 102667.5 78048.0 82052.6 82962.0 84326.0 87588.6 8453.7 8485.1 8530.9 8592.1 8624.9 53259.7 53515.5 54114.0 54192.5 56291.7 68416.7 77977.6 78617.0 78864.6 79116.0 11285.0 11355.2 11649.9 11729.8 11813.3 13552.5 13689.7 13704.0 13779.9 14561.9 11569.1 11629.9 11659.9 11871.1 12195.3 11928.2 12042.9 12230.0 12324.9 12641.2 11369.7 11454.6 11626.5 11642.2 11670.2 10276.3 10324.2 10531.2 10748.1 10766.8 10143.5 10381.3 10399.4 10500.9 10517.7 07:17:00 INFO - PROCESS | 8762 | -------- Summary: end -------- 07:17:00 INFO - PROCESS | 8762 | 07:17:01 INFO - TEST-INFO | 8762: exit 0 07:17:01 INFO - TEST-OK | dromaeo_css | took 1111268ms 07:17:01 INFO - TEST-START | kraken 07:17:01 INFO - operating with platform_type : linux_ 07:17:01 INFO - Initialising browser for kraken test... 07:17:01 INFO - TEST-INFO | started process 9001 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMnPpsg/profile http://localhost:55715/getInfo.html) 07:17:05 INFO - PROCESS | 9001 | __metrics Screen width/height:1600/1200 07:17:05 INFO - PROCESS | 9001 | colorDepth:24 07:17:05 INFO - PROCESS | 9001 | Browser inner width/height: 1024/697 07:17:05 INFO - PROCESS | 9001 | __metrics 07:17:06 ERROR - PROCESS | 9001 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 07:17:07 INFO - TEST-INFO | 9001: exit 0 07:17:07 INFO - Browser initialized. 07:17:07 INFO - Running cycle 1/1 for kraken test... 07:17:07 INFO - TEST-INFO | started process 9128 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMnPpsg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:17:18 INFO - PROCESS | 9128 | RSS: Main: 167616512 07:17:18 INFO - PROCESS | 9128 | 07:17:21 INFO - PROCESS | 9128 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55715/tests/kraken/driver.html?testName=audio-beat-detection) 07:17:22 INFO - PROCESS | 9128 | RSS: Main: 173330432 07:17:22 INFO - PROCESS | 9128 | 07:17:24 INFO - PROCESS | 9128 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55715/tests/kraken/driver.html?testName=audio-dft) 07:17:25 INFO - PROCESS | 9128 | RSS: Main: 172216320 07:17:25 INFO - PROCESS | 9128 | 07:17:28 INFO - PROCESS | 9128 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55715/tests/kraken/driver.html?testName=audio-fft) 07:17:29 INFO - PROCESS | 9128 | RSS: Main: 167215104 07:17:29 INFO - PROCESS | 9128 | 07:17:31 INFO - PROCESS | 9128 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55715/tests/kraken/driver.html?testName=audio-oscillator) 07:17:31 INFO - PROCESS | 9128 | RSS: Main: 167735296 07:17:31 INFO - PROCESS | 9128 | 07:17:34 INFO - PROCESS | 9128 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55715/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:17:34 INFO - PROCESS | 9128 | RSS: Main: 168603648 07:17:34 INFO - PROCESS | 9128 | 07:17:37 INFO - PROCESS | 9128 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55715/tests/kraken/driver.html?testName=imaging-darkroom) 07:17:38 INFO - PROCESS | 9128 | RSS: Main: 168742912 07:17:38 INFO - PROCESS | 9128 | 07:17:41 INFO - PROCESS | 9128 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55715/tests/kraken/driver.html?testName=imaging-desaturate) 07:17:42 INFO - PROCESS | 9128 | RSS: Main: 169340928 07:17:42 INFO - PROCESS | 9128 | 07:17:45 INFO - PROCESS | 9128 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55715/tests/kraken/driver.html?testName=json-parse-financial) 07:17:45 INFO - PROCESS | 9128 | RSS: Main: 168689664 07:17:45 INFO - PROCESS | 9128 | 07:17:47 INFO - PROCESS | 9128 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55715/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:17:48 INFO - PROCESS | 9128 | RSS: Main: 168685568 07:17:48 INFO - PROCESS | 9128 | 07:17:49 INFO - PROCESS | 9128 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55715/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:17:50 INFO - PROCESS | 9128 | RSS: Main: 169390080 07:17:50 INFO - PROCESS | 9128 | 07:17:52 INFO - PROCESS | 9128 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55715/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:17:53 INFO - PROCESS | 9128 | RSS: Main: 169668608 07:17:53 INFO - PROCESS | 9128 | 07:17:55 INFO - PROCESS | 9128 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55715/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:17:56 INFO - PROCESS | 9128 | RSS: Main: 169693184 07:17:56 INFO - PROCESS | 9128 | 07:17:59 INFO - PROCESS | 9128 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55715/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:17:59 INFO - PROCESS | 9128 | RSS: Main: 169451520 07:17:59 INFO - PROCESS | 9128 | 07:18:01 INFO - PROCESS | 9128 | Cycle 1(1): loaded http://localhost:55715/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55715/tests/kraken/driver.html?testName=ai-astar) 07:18:01 INFO - PROCESS | 9128 | RSS: Main: 170156032 07:18:01 INFO - PROCESS | 9128 | 07:18:01 INFO - PROCESS | 9128 | __start_tp_report 07:18:01 INFO - PROCESS | 9128 | _x_x_mozilla_page_load 07:18:01 INFO - PROCESS | 9128 | _x_x_mozilla_page_load_details 07:18:01 INFO - PROCESS | 9128 | |i|pagename|runs| 07:18:01 INFO - PROCESS | 9128 | |0;ai-astar;102;115;107;112;112;113;115;113;112;112 07:18:01 INFO - PROCESS | 9128 | |1;audio-beat-detection;152;120;141;174;120;150;149;120;192;120 07:18:01 INFO - PROCESS | 9128 | |2;audio-dft;163;162;163;161;162;164;167;168;163;163 07:18:01 INFO - PROCESS | 9128 | |3;audio-fft;80;75;75;174;76;75;74;76;167;76 07:18:01 INFO - PROCESS | 9128 | |4;audio-oscillator;84;83;157;84;84;84;148;83;83;151 07:18:01 INFO - PROCESS | 9128 | |5;imaging-gaussian-blur;117;117;118;117;118;117;117;118;117;118 07:18:01 INFO - PROCESS | 9128 | |6;imaging-darkroom;146;147;146;147;147;147;146;147;147;147 07:18:01 INFO - PROCESS | 9128 | |7;imaging-desaturate;95;96;95;95;96;96;95;96;95;95 07:18:01 INFO - PROCESS | 9128 | |8;json-parse-financial;53;56;53;54;54;58;54;56;55;56 07:18:01 INFO - PROCESS | 9128 | |9;json-stringify-tinderbox;61;63;62;63;64;62;64;63;63;62 07:18:01 INFO - PROCESS | 9128 | |10;stanford-crypto-aes;84;76;74;81;82;75;79;75;80;75 07:18:01 INFO - PROCESS | 9128 | |11;stanford-crypto-ccm;131;128;132;137;135;123;122;124;161;132 07:18:01 INFO - PROCESS | 9128 | |12;stanford-crypto-pbkdf2;161;153;153;158;156;156;156;160;155;155 07:18:01 INFO - PROCESS | 9128 | |13;stanford-crypto-sha256-iterative;62;62;64;65;64;64;64;63;65;66 07:18:01 INFO - PROCESS | 9128 | __end_tp_report 07:18:01 INFO - PROCESS | 9128 | __start_cc_report 07:18:01 INFO - PROCESS | 9128 | _x_x_mozilla_cycle_collect,901 07:18:01 INFO - PROCESS | 9128 | __end_cc_report 07:18:01 INFO - PROCESS | 9128 | __startTimestamp1468505881865__endTimestamp 07:18:01 INFO - PROCESS | 9128 | 07:18:01 INFO - PROCESS | 9128 | ------- Summary: start ------- 07:18:01 INFO - PROCESS | 9128 | Number of tests: 14 07:18:01 INFO - PROCESS | 9128 | 07:18:01 INFO - PROCESS | 9128 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.50 stddev:3.95 (3.5%) stddev-sans-first:2.35 07:18:01 INFO - PROCESS | 9128 | Values: 102.0 115.0 107.0 112.0 112.0 113.0 115.0 113.0 112.0 112.0 07:18:01 INFO - PROCESS | 9128 | 07:18:01 INFO - PROCESS | 9128 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:149.50 stddev:25.04 (16.7%) stddev-sans-first:26.38 07:18:01 INFO - PROCESS | 9128 | Values: 152.0 120.0 141.0 174.0 120.0 150.0 149.0 120.0 192.0 120.0 07:18:01 INFO - PROCESS | 9128 | 07:18:01 INFO - PROCESS | 9128 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:2.22 (1.4%) stddev-sans-first:2.35 07:18:01 INFO - PROCESS | 9128 | Values: 163.0 162.0 163.0 161.0 162.0 164.0 167.0 168.0 163.0 163.0 07:18:01 INFO - PROCESS | 9128 | 07:18:01 INFO - PROCESS | 9128 | [#3] audio-fft Cycles:10 Average:94.80 Median:75.50 stddev:39.96 (52.9%) stddev-sans-first:42.03 07:18:01 INFO - PROCESS | 9128 | Values: 80.0 75.0 75.0 174.0 76.0 75.0 74.0 76.0 167.0 76.0 07:18:01 INFO - PROCESS | 9128 | 07:18:01 INFO - PROCESS | 9128 | [#4] audio-oscillator Cycles:10 Average:104.10 Median:83.50 stddev:33.13 (39.7%) stddev-sans-first:34.33 07:18:01 INFO - PROCESS | 9128 | Values: 84.0 83.0 157.0 84.0 84.0 84.0 148.0 83.0 83.0 151.0 07:18:01 INFO - PROCESS | 9128 | 07:18:01 INFO - PROCESS | 9128 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 07:18:01 INFO - PROCESS | 9128 | Values: 117.0 117.0 118.0 117.0 118.0 117.0 117.0 118.0 117.0 118.0 07:18:01 INFO - PROCESS | 9128 | 07:18:01 INFO - PROCESS | 9128 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 07:18:01 INFO - PROCESS | 9128 | Values: 146.0 147.0 146.0 147.0 147.0 147.0 146.0 147.0 147.0 147.0 07:18:01 INFO - PROCESS | 9128 | 07:18:01 INFO - PROCESS | 9128 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 07:18:01 INFO - PROCESS | 9128 | Values: 95.0 96.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 95.0 07:18:01 INFO - PROCESS | 9128 | 07:18:01 INFO - PROCESS | 9128 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.50 stddev:1.60 (2.9%) stddev-sans-first:1.54 07:18:01 INFO - PROCESS | 9128 | Values: 53.0 56.0 53.0 54.0 54.0 58.0 54.0 56.0 55.0 56.0 07:18:01 INFO - PROCESS | 9128 | 07:18:01 INFO - PROCESS | 9128 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:63.00 stddev:0.95 (1.5%) stddev-sans-first:0.78 07:18:01 INFO - PROCESS | 9128 | Values: 61.0 63.0 62.0 63.0 64.0 62.0 64.0 63.0 63.0 62.0 07:18:01 INFO - PROCESS | 9128 | 07:18:01 INFO - PROCESS | 9128 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:79.50 stddev:3.54 (4.5%) stddev-sans-first:3.05 07:18:01 INFO - PROCESS | 9128 | Values: 84.0 76.0 74.0 81.0 82.0 75.0 79.0 75.0 80.0 75.0 07:18:01 INFO - PROCESS | 9128 | 07:18:01 INFO - PROCESS | 9128 | [#11] stanford-crypto-ccm Cycles:10 Average:132.50 Median:132.00 stddev:11.23 (8.5%) stddev-sans-first:11.90 07:18:01 INFO - PROCESS | 9128 | Values: 131.0 128.0 132.0 137.0 135.0 123.0 122.0 124.0 161.0 132.0 07:18:01 INFO - PROCESS | 9128 | 07:18:01 INFO - PROCESS | 9128 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.30 Median:156.00 stddev:2.67 (1.7%) stddev-sans-first:2.22 07:18:01 INFO - PROCESS | 9128 | Values: 161.0 153.0 153.0 158.0 156.0 156.0 156.0 160.0 155.0 155.0 07:18:01 INFO - PROCESS | 9128 | 07:18:01 INFO - PROCESS | 9128 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.90 Median:64.00 stddev:1.29 (2.0%) stddev-sans-first:1.17 07:18:01 INFO - PROCESS | 9128 | Values: 62.0 62.0 64.0 65.0 64.0 64.0 64.0 63.0 65.0 66.0 07:18:01 INFO - PROCESS | 9128 | -------- Summary: end -------- 07:18:01 INFO - PROCESS | 9128 | 07:18:02 INFO - TEST-INFO | 9128: exit 0 07:18:02 INFO - TEST-OK | kraken | took 61678ms 07:18:02 INFO - SUITE-END | took 1172s 07:18:03 INFO - Completed test suite (00:19:33) 07:18:03 INFO - javascript benchmark 07:18:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7253.126279394629, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3040.3463255400084, 3106.7669924755637, 3110.65782763896, 3122.703343182397, 3147.7009684080003, 5475.67145971242, 5483.287172667553, 5542.972285138574, 5569.777208911639, 5581.2186293918785, 5448.945510544893, 5466.644668096581, 5486.0, 5544.390117087128, 5609.691466969315, 4775.172615707423, 4874.853754387365, 4937.481564435737, 5068.265101560271, 5187.351581052369, 5096.210087436453, 5115.9488405116035, 5146.305248791421, 5152.330197074375, 5213.035588416136, 4883.072216278913, 4956.950430495703, 4976.2784396262705, 4979.053979743837, 5025.120603894322, 4936.851894443173, 4961.355023846877, 4973.4280557735965, 4976.850694479172, 4985.576226020793, 4867.853964381075, 4909.607231421478, 4973.651844370896, 4996.475370086125, 5010.52400022001, 5460.262864513319, 5489.615726899118, 5498.477644623795, 5552.333719953591, 5580.804671836466, 5884.499817515473, 5897.203877476529, 5912.142739302777, 5912.290525136968, 5930.584859059867, 5715.857103572403, 5916.497097746696, 5958.880822383528, 5999.040153575451, 6002.909956350614, 5508.421615730371, 5563.165525171256, 5569.359523654791, 5627.521660658849, 5676.233708449347, 6035.969820150871, 6059.8485037873525, 6099.603525770899, 6099.9085013724825, 6137.478314343241, 5704.686242256633, 5793.507551858055, 5830.591858569945, 5881.676507792027, 5893.705314734246, 5943.197668314722, 5950.642961422329, 5970.910436343458, 5975.492083172892, 6014.218151640259, 5664.68844213564, 5779.682117483579, 5824.0, 5878.206442130343, 5943.673097979653, 5696.544276457957, 5822.214001109796, 5866.1494083357675, 5918.437748413894, 5933.139694744238, 4490.461144662596, 4512.323151527297, 4512.909741805145, 4564.452265728134, 4570.840020599263, 3967.6032396760093, 4008.6592639625374, 4012.25773231953, 4015.357542793139, 4040.5353384360587, 5500.972495137498, 5552.555795536347, 5595.944040559623, 5694.97152514243, 5750.597458177971, 5884.882302353929, 5891.882162356729, 5902.940970590239, 5903.114532820111, 5904.881902361929, 5635.577331700057, 5636.577256705764, 5651.0, 5669.518090962232, 5675.1487276907965, 4966.609349382179, 5045.495450454925, 5059.595232381401, 5086.160783470686, 5095.694258344512, 6094.481969032593, 6138.07928810673, 6148.1085242639565, 6149.108379284979, 6161.537884658668, 5982.850428739316, 5988.041913293852, 5988.311344195299, 5988.431099045583, 5990.221271234712, 6003.219581454383, 6090.908636370546, 6106.15732346443, 6118.479929206067, 6180.721867515883, 5882.970585147047, 5892.823215303548, 5893.469587737124, 5893.616914900518, 5934.554908381802, 5800.477956983892, 5935.0503919372695, 5942.286925568959, 5993.730282137227, 6005.939940600538, 5604.0, 5771.653700777967, 5787.247657804459, 5826.621269617462, 5859.0, 5625.268715067015, 5733.5126514245085, 5753.108268218432, 5754.7122643866805, 5757.165211044459, 5733.369329373682, 5777.7977770777825, 5788.479036886701, 5796.275465566804, 5830.737616807169, 5803.593748437737, 5815.592908496534, 5871.911921321098, 5900.586958912835, 5948.702564871653, 5548.944510555004, 5601.663900166003, 5625.690587017753, 5663.008973429715, 5803.303603567599], "value": 5446.5019409317865, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.9452054794522, 589.3605438099662, 601.8856417280717, 602.1569802276812, 629.7638385605399, 38884.0, 43184.0, 43330.0, 43395.78302108489, 43431.0, 42730.78634606823, 43310.35034474485, 43328.78335608325, 43337.56662433375, 43367.783161084226, 8794.560271986391, 8896.154865287788, 8956.238719708832, 8963.910360896372, 8982.19160275575, 8803.20771130598, 8847.955760221223, 8906.153915378061, 8927.06265842087, 8932.776680582972, 8715.651373945066, 8739.650413983465, 8741.388102832805, 8749.431286966359, 8766.0, 8872.556372181398, 8886.911130888706, 8905.688300909469, 8918.10818918103, 8949.59726812295, 8713.956430217871, 8842.734717958407, 8867.246284065863, 8873.73378798637, 8883.911160888372, 41500.37749433761, 41551.0, 41644.167116657496, 41996.37005444921, 42032.57967420348, 3385.407553678121, 3403.795772253648, 3443.6728510791436, 3492.0746002309406, 3509.6841284284283, 32527.837360813282, 32782.50826237608, 33004.83497582521, 33111.14756216974, 33791.0, 4463.4866990296205, 4485.461744590637, 4501.617362524189, 4521.0, 4642.3500709900645, 376905.0, 378598.0, 379474.0, 380018.0, 380625.0, 31783.682163178073, 32780.836095819366, 57394.7130264346, 57494.42505574974, 57538.424615753305, 35232.823835880656, 35519.82240088783, 35521.46717799235, 35684.107897302776, 35702.10744731351, 15043.323050462755, 15182.772258416133, 15184.620384490476, 15199.848001520064, 15269.0, 12445.37773111359, 12465.626031219077, 12469.127161098637, 12506.562270320495, 12528.123031387715, 8225.259726624632, 8256.0, 8260.0, 8269.46248493846, 8359.122292159358, 3173.4129186100186, 3175.71418572325, 3209.0, 3216.292415668549, 3262.869485220612, 1021.97445063874, 1033.6640591807693, 1115.6374178391893, 1123.084685980923, 1124.651358078998, 32992.67007329944, 33262.833685831414, 33269.3346133076, 33638.831805841306, 33979.49030764541, 1094.4035500652165, 1118.6532175025768, 1127.774445110981, 1146.3351256271342, 1202.3627477436971, 17347.479575612753, 17594.64810703779, 17623.38318158884, 17669.38157164493, 17729.911350443424, 605858.0, 610188.0, 615977.0, 617441.0, 619396.0, 59356.70321648451, 59604.70197648984, 59884.401155987885, 59953.0, 60008.699956499935, 1338.645259006364, 1376.9793453098412, 1379.6412932637586, 1382.9446822127204, 1390.4299237312653, 31699.36601268008, 32696.0, 32763.836180818944, 33031.50452743163, 33137.0, 52179.0, 52444.21333680074, 52873.0, 52937.20594191167, 53033.46966530285, 464596.0, 465292.0, 466454.0, 466575.0, 467707.0, 27945.0, 27982.0, 28086.157415277576, 28536.85731571329, 28648.14055578336, 48321.27518087302, 49567.75216123896, 49807.252891205935, 50107.74946125246, 50338.244926326865, 43020.35469468023, 43033.784831075645, 43165.0, 43189.352159718255, 44326.55673443224, 43116.00541861931, 43293.86362398377, 43458.0, 43613.34579981239, 44092.55907441013, 36627.45058824067, 40310.0, 41034.58965410427, 41780.58219417888, 42979.0, 36658.45012324871, 38683.80658096691, 39125.6087439122, 39301.0, 39760.80119599384, 29282.0, 29384.0, 29411.705882940896, 29471.0, 29530.704692953655], "value": 19162.864750422264, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.4585628498626, 382.7760759955426, 386.64815018333303, 397.59246772058657, 401.4259608759473, 17865.464036078924, 18757.531061723428, 20455.59088818223, 20492.385228443152, 20518.487037824063, 12122.636320910366, 12549.176435302052, 12666.49334026638, 12691.365431728424, 19294.517637059045, 5200.557952574026, 5330.227117068022, 5332.733363331838, 5344.4922732340365, 5367.221752845835, 3828.119532507511, 5144.279800827887, 6350.523710721691, 6524.217093948709, 6606.075149479077, 6488.25385080717, 6504.804855854332, 6506.674666266667, 6550.508711846607, 6562.015697645344, 5989.0, 6319.6524191169465, 6333.683315834213, 6357.364263573606, 6395.16862807832, 5530.5852061095575, 5801.564882633819, 5818.41815818419, 5828.5628577856405, 5843.240378750777, 12234.877651223553, 12371.505139794397, 12383.257004579664, 20904.163833446644, 22326.776732232633, 2314.7963059209287, 2516.8615726135054, 2573.4853029394008, 2655.2830735701255, 2995.8352290624007, 9735.0, 9878.753031174207, 10275.588976440933, 10433.426161561187, 10685.626003089932, 1878.229925730444, 1969.6257711035, 1975.1210711233507, 1996.7104769808298, 2048.805363490466, 87830.56084719536, 90638.0, 91119.08880911239, 91777.0, 92137.61793573102, 11117.833232501518, 11165.720856978478, 11247.775044499063, 11248.887511124783, 11377.0, 15747.68504629901, 15765.448209312848, 15917.761233581505, 15933.760993585105, 15948.2823272953, 8238.629261683238, 8288.751337459886, 8426.368022398345, 8459.661613535389, 8467.449615774955, 7863.567503787232, 7917.7624671259955, 7918.670445456085, 7922.485038472596, 8058.3150432213915, 4606.286025665961, 4704.694194877322, 4758.833440829623, 4855.198892182821, 4873.342098816685, 1981.564055907698, 1996.0319245166083, 2003.3589251439691, 2006.9698954515693, 2038.2967876082728, 1042.7497400623947, 1051.4427353502656, 1066.7173199102244, 1073.6993641780314, 1076.7308172956762, 19698.0, 19742.90128549377, 19916.103775330146, 19953.60092798136, 19975.300864469675, 964.238251781099, 971.0920289529172, 976.6093562575027, 999.1507218864053, 1028.3521381529588, 10630.787384252271, 11052.281601695864, 11054.668359949215, 11083.667489975314, 11104.555817767361, 496619.0, 513682.0, 533651.0, 544898.0, 547192.64036798, 79342.0, 84031.5798421004, 89433.55283223672, 97503.0, 98202.0, 989.8267803134422, 1017.4048181813574, 1018.3533456255183, 1018.5671089786811, 1021.2748948246827, 15290.923545382648, 17522.211500482765, 17616.29534818593, 18319.816801832345, 18420.447386578424, 41520.377194341505, 42009.78995105005, 42448.36327455152, 42803.357949631405, 44700.10599788051, 60187.39812601818, 61370.0, 61926.69036654788, 62132.0, 62566.687166563876, 8418.116097809641, 8653.091425400495, 8691.652333906573, 8874.60064297121, 8984.326175536991, 11742.236754610924, 12813.551525696555, 12834.037447191311, 12985.545505907248, 13077.411516481972, 10458.0, 10579.62971296001, 10600.787984240118, 10823.080038196842, 10948.124150068135, 10843.891561084603, 11082.279651822606, 11260.7747845041, 11288.322700637988, 11434.142439316918, 9932.205423565953, 9962.053604907522, 10616.363018218623, 10630.627928022483, 10886.836697449386, 8443.408961372645, 8535.189157030072, 8727.91272087271, 8746.69386571467, 8862.335324850534, 10051.597936082475, 10241.692749217535, 10485.68542943713, 10545.36727796304, 10560.683179504627], "value": 9151.11438659721, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1449.5289031064904, 1474.3586539855164, 1597.4967885116187, 1760.8503277221434, 1778.0754007915884, 7468.701251949916, 8554.700585479502, 8599.183077607633, 9157.221636160926, 9190.908090919089, 8592.957035214831, 8825.646974121028, 8948.776280592972, 8950.507722075283, 8967.372283940127, 2351.976480235193, 2357.2221167014845, 2390.497995420964, 2391.5097405031925, 2394.724606670229, 2338.543983923136, 2340.4850932794757, 2351.1183306260154, 2358.127492827656, 2364.869932153731, 2336.4976530046038, 2338.2166974063625, 2342.1919437793936, 2360.468894498741, 2401.3396316013063, 2317.4206448387904, 2328.906843726249, 2330.5338932213626, 2331.918382856592, 2380.25022118034, 2322.500662357584, 2324.233003108987, 2337.322176568793, 2337.6844126043106, 2342.203650758733, 8792.824143517159, 8901.510416927067, 9008.099190081006, 9021.954890225572, 9063.184313411824, 5387.4612538746205, 5450.972745136249, 5489.533389661883, 5496.5053145217125, 5516.062269414169, 3497.178163131662, 3507.4037413639744, 3516.7010804081683, 3545.468179773029, 3550.7336949728615, 1156.9652910412701, 1167.357953125786, 1222.944967476457, 1226.4542278685988, 1245.1346314311556, 12266.325352105541, 12405.131640785148, 12433.191842530297, 12445.502179912794, 12450.564230251988, 4738.691985020962, 4772.641114148305, 4830.850271629091, 4857.9028419431415, 4956.3804524434445, 10810.189235807346, 10843.945780271048, 10867.673969780919, 10884.346939183675, 10926.617568385069, 5516.117421212587, 5523.613347065667, 5525.254090697785, 5532.336119665585, 5533.695646739468, 4124.422580838685, 4926.605871530269, 5081.923771143436, 5084.872878178076, 5096.133657278272, 4064.1058967027207, 4096.669906186141, 4103.528094269138, 4138.875833724993, 4154.5222299435345, 1205.7829590673587, 1307.5096838685492, 1313.343328335832, 1315.4475120449433, 1341.93961271743, 870.9695160669346, 906.5014242166782, 965.3146266150972, 973.464594473037, 1028.9485525723685, 6031.09533569968, 6144.723487443076, 6184.536159788034, 6197.96901015492, 6378.457831084317, 972.4845831709206, 988.19462138357, 999.430893497217, 1018.6434747838198, 1027.3168343051937, 4173.812178451977, 4354.825806967686, 4388.846390376321, 4400.9559904401185, 4453.599176074104, 11082.390468524147, 11412.657620271406, 11435.428228588537, 11455.198136130557, 11561.248518846249, 11403.0, 11412.372319522507, 11424.257423267627, 11448.885511144948, 11456.541738330374, 7882.172371900982, 8183.386246031571, 8184.427090103635, 8474.1949514796, 8628.266597339296, 6365.90451143224, 6720.865582688417, 6735.730570777114, 6737.69680364375, 6749.426298764463, 10361.689149325532, 10398.324108932895, 10457.529411176667, 10514.106300964504, 10526.368417894952, 10346.482675866026, 10461.215408844215, 10688.465576721288, 10816.242862999514, 10833.02502774754, 6922.134733158356, 7346.6326683666675, 7585.772426827204, 7990.240927111915, 8116.188381161836, 8567.057623661267, 8590.055093939536, 8613.353998450266, 8650.307975362082, 8710.47737135774, 7695.615219238904, 7894.171112033154, 7966.482178658369, 7971.601419929097, 7988.880166797387, 7706.7687969361, 7755.379569634303, 7772.339351154989, 7851.921480785348, 7856.7250146244605, 7120.430365570845, 7165.104361954755, 7184.9640751798, 7218.3036986307125, 7228.060352154186, 4927.137750893651, 5169.689818610896, 5198.610104242272, 5291.682499050069, 5305.734713264398, 4926.113299606105, 5009.3487846581165, 5030.647854650139, 5063.873403164803, 5098.464661210668], "value": 4768.026890183428, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.2965645922511, 332.55935884952436, 333.2584998378607, 335.1888429999401, 337.86654271562736, 5533.418991005942, 5628.8592785180335, 5677.545796336293, 5699.373068962411, 5742.497076783159, 5567.805126820562, 5577.079781836002, 5577.832665020046, 5579.38626751057, 5586.944130558693, 4368.0, 4369.541198174194, 4376.715513491628, 4378.562143785628, 4382.9342559861625, 4247.851325203618, 4312.2453570625175, 4342.370356298351, 4363.214621368153, 4403.295472724365, 4277.438734861768, 4308.612224899758, 4315.978420107911, 4316.84891028814, 4324.805383757723, 4325.156594464081, 4335.848245311399, 4341.5441378655105, 4354.978225108885, 4367.192069467159, 3552.946705799415, 3760.567534733513, 3851.4607954886337, 3854.614538546151, 3857.8263978121054, 5468.91796623051, 5477.178423236506, 5479.369872464637, 5481.643693159932, 5503.394626591072, 4908.828191013333, 4942.604591632661, 4946.653734238605, 4961.3798275215595, 4989.954118811306, 5590.049691552445, 5776.855578610526, 5816.2260510544265, 5847.298324201123, 5871.735771890275, 4109.630133288018, 4113.642497975661, 4114.753114813121, 4137.275976704064, 4137.731047481904, 5853.795117170921, 5897.882042359129, 6067.484263837579, 6089.695515224265, 6100.72546735398, 4170.374443833389, 4184.832606695759, 4185.309423945076, 4186.539480657125, 4193.811278492475, 4253.63844073251, 4272.401863739079, 4280.459034747489, 4285.250081235771, 4285.885669725832, 4663.253879379351, 4927.95072049282, 4928.186849169919, 4946.1344264753525, 4950.18321976877, 5877.617954832922, 5880.441358070976, 5893.528517718572, 5896.823095307148, 5903.616264942765, 1456.5411895252962, 1468.5227301127177, 1472.8674419302315, 1477.0, 1478.6746915678534, 904.202022353344, 938.5635679409107, 938.671464987249, 942.2885721280527, 942.3921570586933, 5046.855086588185, 5055.51972562606, 5064.518870707277, 5071.492850714899, 5095.26118712792, 5267.656747529432, 5341.009034940445, 5352.464753524617, 5360.46209501727, 5368.8389348319615, 5069.188929771292, 5069.239614057921, 5121.231815227746, 5356.4107948125675, 5797.971010145006, 3170.2708377073404, 3214.9678503215137, 3219.114743445571, 3238.498032804919, 3241.6434192238835, 6147.477464415485, 6241.313455519889, 6249.406306400884, 6260.561760676709, 6337.904931426032, 6148.815535533941, 6184.196054512884, 6189.102580125857, 6223.253209614875, 6230.59501132425, 6198.690065496708, 6230.439260466489, 6231.597890474607, 6240.126382306481, 6266.49868010558, 5787.508061814793, 6034.879302414015, 6062.302835174011, 6062.514998800174, 6072.392760724069, 5985.65322802366, 5987.580869339278, 6018.789342372996, 6022.668753218615, 6025.548083893638, 5941.257342832146, 6075.2405949256345, 6218.875622487615, 6243.250809902841, 6267.62394256346, 4266.807993640356, 4267.210566045292, 4291.914161716811, 4293.205756934977, 4323.2650449423045, 5838.241028666416, 5991.584796665858, 6006.339302676614, 6006.909896351471, 6029.161105862754, 5805.245318108618, 5807.82576522705, 5847.152162936265, 5858.736356864037, 5922.911156332744, 5793.652380857162, 5851.180834683233, 5856.443637854397, 5867.559933004956, 5888.116782482662, 5584.609077364546, 5688.886222275614, 5763.7406316715005, 5790.26292112373, 5794.565407594363, 5755.5971082025535, 5819.79630712923, 5875.236219291465, 5876.735546900314, 5881.647101173943, 5489.505944465017, 5701.515371193495, 5714.457096583982, 5763.394843541536, 5812.651240925558], "value": 4409.912529967919, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.8961910085443, 642.2870613618885, 644.2558844534565, 656.3075954867613, 663.8108139180334, 13184.143030702997, 13462.5288114916, 14956.177410242446, 15230.314635841387, 15350.846491535109, 15733.921330393332, 15783.368665253376, 15804.762928556082, 15838.0, 15855.3657853686, 782.2216894190288, 788.4874831359633, 804.9839003219932, 819.5410570080744, 828.5732847583499, 815.1522416686669, 815.3762371785589, 816.7019038051099, 818.071488860142, 820.9014918209793, 846.2468403121227, 847.1401527449643, 847.7499137754346, 848.3594885861166, 849.6389034660275, 842.8567143585544, 843.1652663862762, 843.4264700003995, 843.6751850537526, 844.3793811548506, 613.5030625193563, 615.8645098078416, 616.0, 616.8057062025448, 616.8735409241095, 15170.31733571992, 15305.387784488606, 15314.846851531565, 15321.310541025681, 15347.155906425141, 14346.856531434762, 14425.639359016004, 14475.0, 14503.492377766728, 14508.347124379428, 11387.316760994285, 11455.484503197376, 11532.077433805276, 11546.076313894951, 11699.941500292443, 3793.1275806564645, 3816.084139806454, 3915.451836742858, 3993.341098718737, 3994.320965435854, 82240.58879705564, 82498.58750706268, 85500.0, 85951.57024214839, 86661.0, 10496.370217786805, 10800.405977671304, 10836.467050144292, 10845.728856778644, 10917.563297468012, 20787.272445464336, 20908.58182836335, 21005.36983890486, 21008.054637541347, 21024.369268921957, 7498.025256716701, 7721.112072111779, 8279.047909490366, 8303.750887473385, 8398.41211115216, 4513.323001549728, 4548.809057994365, 4623.722576645412, 4666.393368862026, 4745.644076694192, 3343.8996830095134, 3458.7405944554257, 3463.3765922134257, 3464.064702530303, 3466.5146879436898, 593.4006653280218, 605.4187979539691, 614.6895817612077, 618.5793660311032, 627.97802076928, 558.3160628230386, 578.8094198006403, 602.430668109577, 660.0561197487639, 672.7140965089817, 9146.451212927246, 9290.334162797782, 9353.204977576983, 9383.906160938302, 9479.905200947902, 658.5620562326095, 680.8025672554903, 682.2972338491362, 686.1286166568431, 695.9967739205313, 4429.446319210098, 4440.777961101997, 4481.1933851906315, 4509.413776209138, 4587.082583483317, 112364.43817780858, 115469.42265288619, 116427.41786291014, 120847.0, 121163.39418302852, 59366.703166483894, 62156.06765898515, 89432.0, 102413.0, 102667.48666256771, 78048.0, 82052.58973705213, 82962.0, 84326.0, 87588.56205718931, 8453.661853526037, 8485.109063548485, 8530.914690853013, 8592.140785921358, 8624.870626940476, 53259.73370133124, 53515.464845351045, 54114.0, 54192.45807541874, 56291.71854140703, 68416.6579167101, 77977.61011194908, 78617.0, 78864.60567697124, 79116.0, 11285.0, 11355.205135640426, 11649.88350116488, 11729.765404692029, 11813.291202527877, 13552.457901683822, 13689.657758556115, 13704.040717150103, 13779.862201377859, 14561.92719036398, 11569.132315076235, 11629.883701163219, 11659.892310230514, 11871.109666775199, 12195.268283902995, 11928.224665396721, 12042.879571204176, 12230.0, 12324.876751232372, 12641.2415255085, 11369.658910232707, 11454.599089031844, 11626.476808543466, 11642.221902574842, 11670.241434306743, 10276.280660353703, 10324.174066074545, 10531.21015923824, 10748.140148788234, 10766.838497422701, 10143.543540540546, 10381.273310868166, 10399.428031458343, 10500.894991049992, 10517.737056573647], "value": 7249.2089285607435, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1525.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 115.0, 107.0, 112.0, 112.0, 113.0, 115.0, 113.0, 112.0, 112.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 120.0, 141.0, 174.0, 120.0, 150.0, 149.0, 120.0, 192.0, 120.0], "value": 143.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 161.0, 162.0, 164.0, 167.0, 168.0, 163.0, 163.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 75.0, 75.0, 174.0, 76.0, 75.0, 74.0, 76.0, 167.0, 76.0], "value": 94.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 157.0, 84.0, 84.0, 84.0, 148.0, 83.0, 83.0, 151.0], "value": 104.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 56.0, 53.0, 54.0, 54.0, 58.0, 54.0, 56.0, 55.0, 56.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 62.0, 63.0, 64.0, 62.0, 64.0, 63.0, 63.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 76.0, 74.0, 81.0, 82.0, 75.0, 79.0, 75.0, 80.0, 75.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 128.0, 132.0, 137.0, 135.0, 123.0, 122.0, 124.0, 161.0, 132.0], "value": 132.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 153.0, 153.0, 158.0, 156.0, 156.0, 156.0, 160.0, 155.0, 155.0], "value": 156.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 64.0, 65.0, 64.0, 64.0, 64.0, 63.0, 65.0, 66.0], "value": 63.9, "unit": "score"}]}]} 07:18:03 INFO - Return code: 0 07:18:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:18:03 ERROR - # TBPL SUCCESS # 07:18:03 INFO - Running post-action listener: _resource_record_post_action 07:18:03 INFO - ##### 07:18:03 INFO - ##### Finished run-tests step (success) 07:18:03 INFO - ##### 07:18:03 INFO - Running post-run listener: _resource_record_post_run 07:18:03 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 570064896; Read time: 0; Write time: 416812 07:18:03 INFO - TinderboxPrint: CPU usage
13.3% 07:18:03 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 07:18:03 INFO - TinderboxPrint: I/O write bytes / time
570,064,896 / 416,812 07:18:03 INFO - TinderboxPrint: CPU idle
8,235.0 (86.7%) 07:18:03 INFO - TinderboxPrint: CPU user
1,212.6 (12.8%) 07:18:03 INFO - TinderboxPrint: Swap in / out
0 / 0 07:18:03 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 272961536; Read time: 0; Write time: 242372 07:18:03 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 297103360; Read time: 0; Write time: 174440 07:18:03 INFO - Running post-run listener: _upload_blobber_files 07:18:03 INFO - Blob upload gear active. 07:18:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:18:03 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 07:18:03 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:18:03 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:18:04 INFO - (blobuploader) - INFO - Open directory for files ... 07:18:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:18:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:18:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:04 INFO - (blobuploader) - INFO - Done attempting. 07:18:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:18:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:18:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:09 INFO - (blobuploader) - INFO - Done attempting. 07:18:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:18:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:18:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:18:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:18:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:18:10 INFO - (blobuploader) - INFO - Done attempting. 07:18:10 INFO - (blobuploader) - INFO - Iteration through files over. 07:18:10 INFO - Return code: 0 07:18:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:18:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:18:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3d9f303f19c0944f08282e12eca92f7e0d8fe1020639d38168f2309068b6d6a8f483b2499ab8c3c37d4f1178eaea5d5571d4eb15ece85bd483bde6225736b44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b06a4f321d64c98b54fcc2e24cf6cdfc6f54a3a72bf5b40cd91baa815278e029aebb6fe03ca87026ebbf542ed585c4e59e34106196a63aa865569f26cf94cba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bbd261ad881dcdede670f0cc96fa930001da9e022f8c267427560f31621187571384175c4a5e7b028fd75b9dbc66748626eb5e30b365c9bae8ba12ebb39a49f0"} 07:18:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:18:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:18:10 INFO - Contents: 07:18:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3d9f303f19c0944f08282e12eca92f7e0d8fe1020639d38168f2309068b6d6a8f483b2499ab8c3c37d4f1178eaea5d5571d4eb15ece85bd483bde6225736b44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b06a4f321d64c98b54fcc2e24cf6cdfc6f54a3a72bf5b40cd91baa815278e029aebb6fe03ca87026ebbf542ed585c4e59e34106196a63aa865569f26cf94cba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bbd261ad881dcdede670f0cc96fa930001da9e022f8c267427560f31621187571384175c4a5e7b028fd75b9dbc66748626eb5e30b365c9bae8ba12ebb39a49f0"} 07:18:10 INFO - Running post-run listener: copy_logs_to_upload_dir 07:18:10 INFO - Copying logs to upload dir... 07:18:10 INFO - mkdir: /builds/slave/test/build/upload/logs 07:18:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.597793 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-14 07:18:10.290210) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 07:18:10.293762) ========= 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=41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3d9f303f19c0944f08282e12eca92f7e0d8fe1020639d38168f2309068b6d6a8f483b2499ab8c3c37d4f1178eaea5d5571d4eb15ece85bd483bde6225736b44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b06a4f321d64c98b54fcc2e24cf6cdfc6f54a3a72bf5b40cd91baa815278e029aebb6fe03ca87026ebbf542ed585c4e59e34106196a63aa865569f26cf94cba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bbd261ad881dcdede670f0cc96fa930001da9e022f8c267427560f31621187571384175c4a5e7b028fd75b9dbc66748626eb5e30b365c9bae8ba12ebb39a49f0"} build_url:https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011274 build_url: 'https://queue.taskcluster.net/v1/task/Szesr3yLRYywc9TJDFtwIg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c3d9f303f19c0944f08282e12eca92f7e0d8fe1020639d38168f2309068b6d6a8f483b2499ab8c3c37d4f1178eaea5d5571d4eb15ece85bd483bde6225736b44", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2b06a4f321d64c98b54fcc2e24cf6cdfc6f54a3a72bf5b40cd91baa815278e029aebb6fe03ca87026ebbf542ed585c4e59e34106196a63aa865569f26cf94cba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bbd261ad881dcdede670f0cc96fa930001da9e022f8c267427560f31621187571384175c4a5e7b028fd75b9dbc66748626eb5e30b365c9bae8ba12ebb39a49f0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 07:18:10.319758) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:18:10.320134) ========= 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=41a7e32711b8e08598a63237000001d6-1468504658.415804-1155474648 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004394 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:18:10.402635) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 07:18:10.402997) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 07:18:10.403350) ========= ========= Total master_lag: 0.18 =========