builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-043 starttime: 1467901801.01 results: success (0) buildid: 20160707070123 builduid: 1830e053c27a4a6282bd3761f34a892c revision: ba5ff277a3cd1a7f655f8e02a130a395e8f2a225 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 07:30:01.010743) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 07:30:01.011153) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 07:30:01.011573) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 07:30:01.090582) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 07:30:01.090840) ========= 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=d2a8c569965ab8367867b893000001a1-1467900892.62644-766203591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 07:30:01-- 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% 50.5M=0s 2016-07-07 07:30:01 (50.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.143226 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 07:30:01.249693) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 07:30:01.250001) ========= 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=d2a8c569965ab8367867b893000001a1-1467900892.62644-766203591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018608 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 07:30:01.300028) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 07:30:01.300348) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ba5ff277a3cd1a7f655f8e02a130a395e8f2a225 --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 ba5ff277a3cd1a7f655f8e02a130a395e8f2a225 --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=d2a8c569965ab8367867b893000001a1-1467900892.62644-766203591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 07:30:01,481 truncating revision to first 12 chars 2016-07-07 07:30:01,481 Setting DEBUG logging. 2016-07-07 07:30:01,482 attempt 1/10 2016-07-07 07:30:01,482 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ba5ff277a3cd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 07:30:02,257 unpacking tar archive at: fx-team-ba5ff277a3cd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.237159 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 07:30:02.554972) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 07:30:02.555312) ========= script_repo_revision: ba5ff277a3cd1a7f655f8e02a130a395e8f2a225 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 07:30:02.555738) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 07:30:02.556007) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 07:30:02.573129) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-07 07:30:02.573403) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=d2a8c569965ab8367867b893000001a1-1467900892.62644-766203591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:30:02 INFO - MultiFileLogger online at 20160707 07:30:02 in /builds/slave/test 07:30:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:30:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:30:02 INFO - {'append_to_log': False, 07:30:02 INFO - 'base_work_dir': '/builds/slave/test', 07:30:02 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:30:02 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:30:02 INFO - 'branch': 'Fx-Team-Non-PGO', 07:30:02 INFO - 'buildbot_json_path': 'buildprops.json', 07:30:02 INFO - 'config_files': ('talos/linux_config.py',), 07:30:02 INFO - 'default_actions': ('clobber', 07:30:02 INFO - 'read-buildbot-config', 07:30:02 INFO - 'download-and-extract', 07:30:02 INFO - 'populate-webroot', 07:30:02 INFO - 'create-virtualenv', 07:30:02 INFO - 'install', 07:30:02 INFO - 'run-tests'), 07:30:02 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:30:02 INFO - 'download_minidump_stackwalk': True, 07:30:02 INFO - 'download_symbols': 'ondemand', 07:30:02 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:30:02 INFO - 'tooltool.py': '/tools/tooltool.py', 07:30:02 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:30:02 INFO - '/tools/misc-python/virtualenv.py')}, 07:30:02 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:30:02 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:30:02 INFO - 'installer_path': 'installer.exe', 07:30:02 INFO - 'log_level': 'info', 07:30:02 INFO - 'log_name': 'talos', 07:30:02 INFO - 'log_to_console': True, 07:30:02 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:30:02 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:30:02 INFO - 'opt_config_files': (), 07:30:02 INFO - 'pip_index': False, 07:30:02 INFO - 'sps_profile': False, 07:30:02 INFO - 'sps_profile_interval': 0, 07:30:02 INFO - 'suite': 'dromaeojs-e10s', 07:30:02 INFO - 'system_bits': '32', 07:30:02 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:30:02 INFO - 'title': 'talos-linux64-ix-043', 07:30:02 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:30:02 INFO - 'use_talos_json': True, 07:30:02 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:30:02 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:30:02 INFO - 'work_dir': 'build'} 07:30:02 INFO - ##### 07:30:02 INFO - ##### Running clobber step. 07:30:02 INFO - ##### 07:30:02 INFO - Running pre-action listener: _resource_record_pre_action 07:30:02 INFO - Running main action method: clobber 07:30:02 INFO - rmtree: /builds/slave/test/build 07:30:02 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:30:03 INFO - Running post-action listener: _resource_record_post_action 07:30:03 INFO - ##### 07:30:03 INFO - ##### Finished clobber step (success) 07:30:03 INFO - ##### 07:30:03 INFO - ##### 07:30:03 INFO - ##### Running read-buildbot-config step. 07:30:03 INFO - ##### 07:30:03 INFO - Running pre-action listener: _resource_record_pre_action 07:30:03 INFO - Running main action method: read_buildbot_config 07:30:03 INFO - Using buildbot properties: 07:30:03 INFO - { 07:30:03 INFO - "project": "", 07:30:03 INFO - "product": "firefox", 07:30:03 INFO - "script_repo_revision": "production", 07:30:03 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 07:30:03 INFO - "repository": "", 07:30:03 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 07:30:03 INFO - "buildid": "20160707070123", 07:30:03 INFO - "pgo_build": "False", 07:30:03 INFO - "basedir": "/builds/slave/test", 07:30:03 INFO - "buildnumber": 1423, 07:30:03 INFO - "slavename": "talos-linux64-ix-043", 07:30:03 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:30:03 INFO - "platform": "ubuntu64_hw", 07:30:03 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:30:03 INFO - "branch": "fx-team", 07:30:03 INFO - "repo_path": "integration/fx-team", 07:30:03 INFO - "revision": "ba5ff277a3cd1a7f655f8e02a130a395e8f2a225", 07:30:03 INFO - "stage_platform": "linux64", 07:30:03 INFO - "builduid": "1830e053c27a4a6282bd3761f34a892c", 07:30:03 INFO - "slavebuilddir": "test" 07:30:03 INFO - } 07:30:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:30:03 INFO - Running post-action listener: _resource_record_post_action 07:30:03 INFO - ##### 07:30:03 INFO - ##### Finished read-buildbot-config step (success) 07:30:03 INFO - ##### 07:30:03 INFO - ##### 07:30:03 INFO - ##### Running download-and-extract step. 07:30:03 INFO - ##### 07:30:03 INFO - Running pre-action listener: _resource_record_pre_action 07:30:03 INFO - Running main action method: download_and_extract 07:30:03 INFO - mkdir: /builds/slave/test/build/tests 07:30:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:30:03 INFO - https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:30:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:30:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:30:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/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 07:30:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/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 07:30:03 INFO - Downloaded 1361 bytes. 07:30:03 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:30:03 INFO - Using the following test package requirements: 07:30:03 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:30:03 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:30:03 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:30:03 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:03 INFO - u'jsshell-linux-x86_64.zip'], 07:30:03 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:03 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:30:03 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:30:03 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:30:04 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:30:04 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:30:04 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:30:04 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:30:04 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:30: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')]} 07:30:04 INFO - https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:30:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:30:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:30:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/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 07:30:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/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 07:30:05 INFO - Downloaded 22734516 bytes. 07:30:05 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'] 07:30:05 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 07:30:07 INFO - Return code: 0 07:30:07 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 07:30: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')]} 07:30:07 INFO - https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:30:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:30:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:30:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/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 07:30:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/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 07:30:08 INFO - Downloaded 22734516 bytes. 07:30:08 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'] 07:30:08 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 07:30:10 INFO - Return code: 0 07:30:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:30:10 INFO - https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:30:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:30:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:30:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/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 07:30:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/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 07:30:12 INFO - Downloaded 14403333 bytes. 07:30:12 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'] 07:30:12 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 07:30:12 INFO - Return code: 0 07:30:12 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')]} 07:30:12 INFO - https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:30:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:30:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:30:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/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 07:30:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UFErZw_2Ttu65Pje2xP5wQ/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 07:30:15 INFO - Downloaded 56643000 bytes. 07:30:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:30:15 INFO - mkdir: /builds/slave/test/properties 07:30:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:30:15 INFO - Writing to file /builds/slave/test/properties/build_url 07:30:15 INFO - Contents: 07:30:15 INFO - build_url:https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:30:16 INFO - Running post-action listener: _resource_record_post_action 07:30:16 INFO - Running post-action listener: set_extra_try_arguments 07:30:16 INFO - ##### 07:30:16 INFO - ##### Finished download-and-extract step (success) 07:30:16 INFO - ##### 07:30:16 INFO - ##### 07:30:16 INFO - ##### Running populate-webroot step. 07:30:16 INFO - ##### 07:30:16 INFO - Running pre-action listener: _resource_record_pre_action 07:30:16 INFO - Running main action method: populate_webroot 07:30:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:30:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:30:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:30:16 INFO - '--tppagecycles', 07:30:16 INFO - '7'], 07:30:16 INFO - 'tests': ['tsvgm']}}, 07:30:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:30:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:30:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:30:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:30:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:30:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:30:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:16 INFO - 'talos_options': ['--disable-e10s'], 07:30:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:30:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:30:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:16 INFO - 'talos_options': ['--disable-e10s'], 07:30:16 INFO - 'tests': ['damp', 'tps']}, 07:30:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:16 INFO - 'tests': ['damp', 'tps']}, 07:30:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:30:16 INFO - 'tests': ['dromaeo_dom']}, 07:30:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:30:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:30:16 INFO - 'tests': ['basic_compositor_video']}, 07:30:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:30:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:30:16 INFO - 'tests': ['a11yr', 07:30:16 INFO - 'ts_paint', 07:30:16 INFO - 'tpaint', 07:30:16 INFO - 'sessionrestore', 07:30:16 INFO - 'sessionrestore_no_auto_restore', 07:30:16 INFO - 'tabpaint']}, 07:30:16 INFO - 'other-e10s': {'tests': ['a11yr', 07:30:16 INFO - 'ts_paint', 07:30:16 INFO - 'tpaint', 07:30:16 INFO - 'sessionrestore', 07:30:16 INFO - 'sessionrestore_no_auto_restore', 07:30:16 INFO - 'tabpaint']}, 07:30:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:30:16 INFO - 'ts_paint', 07:30:16 INFO - 'tpaint', 07:30:16 INFO - 'sessionrestore', 07:30:16 INFO - 'sessionrestore_no_auto_restore', 07:30:16 INFO - 'tabpaint']}, 07:30:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:30:16 INFO - 'ts_paint', 07:30:16 INFO - 'tpaint', 07:30:16 INFO - 'sessionrestore', 07:30:16 INFO - 'sessionrestore_no_auto_restore', 07:30:16 INFO - 'tabpaint']}, 07:30:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:30:16 INFO - 'tests': ['a11yr', 07:30:16 INFO - 'ts_paint', 07:30:16 INFO - 'tpaint', 07:30:16 INFO - 'sessionrestore', 07:30:16 INFO - 'sessionrestore_no_auto_restore', 07:30:16 INFO - 'tabpaint']}, 07:30:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:30:16 INFO - 'tests': ['a11yr', 07:30:16 INFO - 'ts_paint', 07:30:16 INFO - 'tpaint', 07:30:16 INFO - 'sessionrestore', 07:30:16 INFO - 'sessionrestore_no_auto_restore', 07:30:16 INFO - 'tabpaint']}, 07:30:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:30:16 INFO - 'tests': ['tsvgx', 07:30:16 INFO - 'tsvgr_opacity', 07:30:16 INFO - 'tart', 07:30:16 INFO - 'tscrollx', 07:30:16 INFO - 'cart']}, 07:30:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:30:16 INFO - 'tsvgr_opacity', 07:30:16 INFO - 'tart', 07:30:16 INFO - 'tscrollx', 07:30:16 INFO - 'cart']}, 07:30:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:16 INFO - 'talos_options': ['--disable-e10s'], 07:30:16 INFO - 'tests': ['tp5o']}, 07:30:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:16 INFO - 'tests': ['tp5o']}, 07:30:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:16 INFO - 'talos_options': ['--disable-e10s', 07:30:16 INFO - '--xperf_path', 07:30:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:30:16 INFO - 'tests': ['tp5n']}, 07:30:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:30:16 INFO - 'talos_options': ['--xperf_path', 07:30:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:30:16 INFO - 'tests': ['tp5n']}}, 07:30:16 INFO - 'talos.zip': {'path': '', 07:30:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:30:16 INFO - Running post-action listener: _resource_record_post_action 07:30:16 INFO - ##### 07:30:16 INFO - ##### Finished populate-webroot step (success) 07:30:16 INFO - ##### 07:30:16 INFO - ##### 07:30:16 INFO - ##### Running create-virtualenv step. 07:30:16 INFO - ##### 07:30:16 INFO - Running pre-action listener: _resource_record_pre_action 07:30:16 INFO - Running main action method: create_virtualenv 07:30:16 INFO - Creating virtualenv /builds/slave/test/build/venv 07:30:16 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 07:30:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:30:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:30:16 INFO - Using real prefix '/usr' 07:30:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:30:16 INFO - Installing distribute.............................................................................................................................................................................................done. 07:30:18 INFO - Installing pip.................done. 07:30:18 INFO - Return code: 0 07:30:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:30:18 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')]} 07:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:18 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')]} 07:30:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:18 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 0x1aa0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e570>, '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 0x1d5f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f900>, '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': 'd2a8c569965ab8367867b893000001a1-1467900892.62644-766203591', '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 07:30:18 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 07:30:18 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 07:30:18 INFO - Using env: {'DISPLAY': ':0', 07:30:18 INFO - 'HOME': '/home/cltbld', 07:30:18 INFO - 'LANG': 'en_US.UTF-8', 07:30:18 INFO - 'LANGUAGE': 'en_US:en', 07:30:18 INFO - 'LOGNAME': 'cltbld', 07:30:18 INFO - 'MAIL': '/var/mail/cltbld', 07:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:18 INFO - 'MOZ_NO_REMOTE': '1', 07:30:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:18 INFO - 'NO_EM_RESTART': '1', 07:30:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:18 INFO - 'PWD': '/builds/slave/test', 07:30:18 INFO - 'SHELL': '/bin/bash', 07:30:18 INFO - 'SHLVL': '1', 07:30:18 INFO - 'TERM': 'linux', 07:30:18 INFO - 'TMOUT': '86400', 07:30:18 INFO - 'USER': 'cltbld', 07:30:18 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467900892.62644-766203591', 07:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:18 INFO - '_': '/tools/buildbot/bin/python'} 07:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:19 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 07:30:19 INFO - Cleaning up... 07:30:19 INFO - Return code: 0 07:30:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:30:19 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')]} 07:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:19 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')]} 07:30:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:19 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 0x1aa0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e570>, '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 0x1d5f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f900>, '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': 'd2a8c569965ab8367867b893000001a1-1467900892.62644-766203591', '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 07:30:19 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 07:30:19 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 07:30:19 INFO - Using env: {'DISPLAY': ':0', 07:30:19 INFO - 'HOME': '/home/cltbld', 07:30:19 INFO - 'LANG': 'en_US.UTF-8', 07:30:19 INFO - 'LANGUAGE': 'en_US:en', 07:30:19 INFO - 'LOGNAME': 'cltbld', 07:30:19 INFO - 'MAIL': '/var/mail/cltbld', 07:30:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:19 INFO - 'MOZ_NO_REMOTE': '1', 07:30:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:19 INFO - 'NO_EM_RESTART': '1', 07:30:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:19 INFO - 'PWD': '/builds/slave/test', 07:30:19 INFO - 'SHELL': '/bin/bash', 07:30:19 INFO - 'SHLVL': '1', 07:30:19 INFO - 'TERM': 'linux', 07:30:19 INFO - 'TMOUT': '86400', 07:30:19 INFO - 'USER': 'cltbld', 07:30:19 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467900892.62644-766203591', 07:30:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:19 INFO - '_': '/tools/buildbot/bin/python'} 07:30:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:19 INFO - Downloading/unpacking psutil>=3.1.1 07:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:30:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:30:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:30:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:30:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:30:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:30:21 INFO - Installing collected packages: psutil 07:30:21 INFO - Running setup.py install for psutil 07:30:21 INFO - building 'psutil._psutil_linux' extension 07:30:21 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 07:30:21 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 07:30:21 INFO - building 'psutil._psutil_posix' extension 07:30:21 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 07:30:21 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 07:30:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:30:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:30:21 INFO - Successfully installed psutil 07:30:21 INFO - Cleaning up... 07:30:21 INFO - Return code: 0 07:30:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:30:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1aa0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e570>, '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 0x1d5f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f900>, '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': 'd2a8c569965ab8367867b893000001a1-1467900892.62644-766203591', '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 07:30:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:30:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:30:21 INFO - Using env: {'DISPLAY': ':0', 07:30:21 INFO - 'HOME': '/home/cltbld', 07:30:21 INFO - 'LANG': 'en_US.UTF-8', 07:30:21 INFO - 'LANGUAGE': 'en_US:en', 07:30:21 INFO - 'LOGNAME': 'cltbld', 07:30:21 INFO - 'MAIL': '/var/mail/cltbld', 07:30:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:21 INFO - 'MOZ_NO_REMOTE': '1', 07:30:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:21 INFO - 'NO_EM_RESTART': '1', 07:30:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:21 INFO - 'PWD': '/builds/slave/test', 07:30:21 INFO - 'SHELL': '/bin/bash', 07:30:21 INFO - 'SHLVL': '1', 07:30:21 INFO - 'TERM': 'linux', 07:30:21 INFO - 'TMOUT': '86400', 07:30:21 INFO - 'USER': 'cltbld', 07:30:21 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467900892.62644-766203591', 07:30:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:21 INFO - '_': '/tools/buildbot/bin/python'} 07:30:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:30:22 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 07:30:22 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 07:30:22 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 07:30:22 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 07:30:22 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 07:30:22 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 07:30:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:30:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:30:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:30:24 INFO - Installing collected packages: mozsystemmonitor 07:30:24 INFO - Running setup.py install for mozsystemmonitor 07:30:24 INFO - Successfully installed mozsystemmonitor 07:30:24 INFO - Cleaning up... 07:30:24 INFO - Return code: 0 07:30:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:30:24 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')]} 07:30:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:24 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')]} 07:30:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:24 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 0x1aa0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e570>, '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 0x1d5f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f900>, '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': 'd2a8c569965ab8367867b893000001a1-1467900892.62644-766203591', '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 07:30:24 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 07:30:24 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 07:30:24 INFO - Using env: {'DISPLAY': ':0', 07:30:24 INFO - 'HOME': '/home/cltbld', 07:30:24 INFO - 'LANG': 'en_US.UTF-8', 07:30:24 INFO - 'LANGUAGE': 'en_US:en', 07:30:24 INFO - 'LOGNAME': 'cltbld', 07:30:24 INFO - 'MAIL': '/var/mail/cltbld', 07:30:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:24 INFO - 'MOZ_NO_REMOTE': '1', 07:30:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:24 INFO - 'NO_EM_RESTART': '1', 07:30:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:24 INFO - 'PWD': '/builds/slave/test', 07:30:24 INFO - 'SHELL': '/bin/bash', 07:30:24 INFO - 'SHLVL': '1', 07:30:24 INFO - 'TERM': 'linux', 07:30:24 INFO - 'TMOUT': '86400', 07:30:24 INFO - 'USER': 'cltbld', 07:30:24 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467900892.62644-766203591', 07:30:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:24 INFO - '_': '/tools/buildbot/bin/python'} 07:30:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:24 INFO - Downloading/unpacking jsonschema==2.5.1 07:30:24 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 07:30:24 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 07:30:24 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 07:30:24 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 07:30:24 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 07:30:24 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 07:30:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:30:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:30:26 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 07:30:26 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 07:30:26 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 07:30:26 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 07:30:26 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 07:30:26 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 07:30:26 INFO - Downloading functools32-3.2.3-2.tar.gz 07:30:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:30:26 INFO - warning: no files found matching '*.txt' 07:30:26 INFO - no previously-included directories found matching 'build' 07:30:26 INFO - no previously-included directories found matching 'dist' 07:30:26 INFO - no previously-included directories found matching '.git*' 07:30:26 INFO - Installing collected packages: jsonschema, functools32 07:30:26 INFO - Running setup.py install for functools32 07:30:26 INFO - warning: no files found matching '*.txt' 07:30:26 INFO - no previously-included directories found matching 'build' 07:30:26 INFO - no previously-included directories found matching 'dist' 07:30:26 INFO - no previously-included directories found matching '.git*' 07:30:26 INFO - Successfully installed jsonschema functools32 07:30:26 INFO - Cleaning up... 07:30:26 INFO - Return code: 0 07:30:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:30:26 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')]} 07:30:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:26 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')]} 07:30:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:26 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 0x1aa0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e570>, '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 0x1d5f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f900>, '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': 'd2a8c569965ab8367867b893000001a1-1467900892.62644-766203591', '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 07:30:26 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 07:30:26 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 07:30:26 INFO - Using env: {'DISPLAY': ':0', 07:30:26 INFO - 'HOME': '/home/cltbld', 07:30:26 INFO - 'LANG': 'en_US.UTF-8', 07:30:26 INFO - 'LANGUAGE': 'en_US:en', 07:30:26 INFO - 'LOGNAME': 'cltbld', 07:30:26 INFO - 'MAIL': '/var/mail/cltbld', 07:30:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:26 INFO - 'MOZ_NO_REMOTE': '1', 07:30:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:26 INFO - 'NO_EM_RESTART': '1', 07:30:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:26 INFO - 'PWD': '/builds/slave/test', 07:30:26 INFO - 'SHELL': '/bin/bash', 07:30:26 INFO - 'SHLVL': '1', 07:30:26 INFO - 'TERM': 'linux', 07:30:26 INFO - 'TMOUT': '86400', 07:30:26 INFO - 'USER': 'cltbld', 07:30:26 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467900892.62644-766203591', 07:30:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:26 INFO - '_': '/tools/buildbot/bin/python'} 07:30:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:26 INFO - Downloading/unpacking blobuploader==1.2.4 07:30:26 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 07:30:26 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 07:30:26 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 07:30:26 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 07:30:26 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 07:30:26 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 07:30:28 INFO - Downloading blobuploader-1.2.4.tar.gz 07:30:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:30:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:30:29 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 07:30:29 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 07:30:29 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 07:30:29 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 07:30:29 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 07:30:29 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 07:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:30:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:30:29 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 07:30:29 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 07:30:29 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 07:30:29 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 07:30:29 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 07:30:29 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 07:30:29 INFO - Downloading docopt-0.6.1.tar.gz 07:30:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:30:29 INFO - Installing collected packages: blobuploader, requests, docopt 07:30:29 INFO - Running setup.py install for blobuploader 07:30:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:30:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:30:29 INFO - Running setup.py install for requests 07:30:30 INFO - Running setup.py install for docopt 07:30:30 INFO - Successfully installed blobuploader requests docopt 07:30:30 INFO - Cleaning up... 07:30:30 INFO - Return code: 0 07:30:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:30:30 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')]} 07:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:30 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')]} 07:30:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:30 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 0x1aa0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e570>, '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 0x1d5f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f900>, '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': 'd2a8c569965ab8367867b893000001a1-1467900892.62644-766203591', '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 07:30:30 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 07:30:30 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 07:30:30 INFO - Using env: {'DISPLAY': ':0', 07:30:30 INFO - 'HOME': '/home/cltbld', 07:30:30 INFO - 'LANG': 'en_US.UTF-8', 07:30:30 INFO - 'LANGUAGE': 'en_US:en', 07:30:30 INFO - 'LOGNAME': 'cltbld', 07:30:30 INFO - 'MAIL': '/var/mail/cltbld', 07:30:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:30 INFO - 'MOZ_NO_REMOTE': '1', 07:30:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:30 INFO - 'NO_EM_RESTART': '1', 07:30:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:30 INFO - 'PWD': '/builds/slave/test', 07:30:30 INFO - 'SHELL': '/bin/bash', 07:30:30 INFO - 'SHLVL': '1', 07:30:30 INFO - 'TERM': 'linux', 07:30:30 INFO - 'TMOUT': '86400', 07:30:30 INFO - 'USER': 'cltbld', 07:30:30 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467900892.62644-766203591', 07:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:30 INFO - '_': '/tools/buildbot/bin/python'} 07:30:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:30:30 INFO - Running setup.py (path:/tmp/pip-tz9BmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:30:30 INFO - Running setup.py (path:/tmp/pip-HsUeak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:30:30 INFO - Running setup.py (path:/tmp/pip-9YsVb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:30:30 INFO - Running setup.py (path:/tmp/pip-lUh3Gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:30:30 INFO - Running setup.py (path:/tmp/pip-RcuJvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:30:30 INFO - Running setup.py (path:/tmp/pip-8NbmVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:30:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:30:30 INFO - Running setup.py (path:/tmp/pip-2W7qDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:30:31 INFO - Running setup.py (path:/tmp/pip-xnFiN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:30:31 INFO - Running setup.py (path:/tmp/pip-2dF0do-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:30:31 INFO - Running setup.py (path:/tmp/pip-KBLJ3o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:30:31 INFO - Running setup.py (path:/tmp/pip-EDzr8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:30:31 INFO - Running setup.py (path:/tmp/pip-9on5Bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:30:31 INFO - Running setup.py (path:/tmp/pip-zHKtyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:30:31 INFO - Running setup.py (path:/tmp/pip-rr0Rm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:31 INFO - Running setup.py (path:/tmp/pip-vu4cyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:30:31 INFO - Running setup.py (path:/tmp/pip-MGtvcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:30:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:30:31 INFO - Running setup.py (path:/tmp/pip-U5hjTW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:30:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:30:31 INFO - Running setup.py install for manifestparser 07:30:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:30:31 INFO - Running setup.py install for mozcrash 07:30:31 INFO - Running setup.py install for mozdebug 07:30:32 INFO - Running setup.py install for mozdevice 07:30:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:30:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:30:32 INFO - Running setup.py install for mozfile 07:30:32 INFO - Running setup.py install for mozhttpd 07:30:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:30:32 INFO - Running setup.py install for mozinfo 07:30:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:30:32 INFO - Running setup.py install for mozInstall 07:30:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:30:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:30:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:30:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:30:32 INFO - Running setup.py install for mozleak 07:30:32 INFO - Running setup.py install for mozlog 07:30:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:30:32 INFO - Running setup.py install for moznetwork 07:30:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:30:32 INFO - Running setup.py install for mozprocess 07:30:32 INFO - Running setup.py install for mozprofile 07:30:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:30:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:30:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:30:33 INFO - Running setup.py install for mozrunner 07:30:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:30:33 INFO - Running setup.py install for mozscreenshot 07:30:33 INFO - Running setup.py install for moztest 07:30:33 INFO - Running setup.py install for mozversion 07:30:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:30:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:30:33 INFO - Cleaning up... 07:30:33 INFO - Return code: 0 07:30:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:30:33 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')]} 07:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:33 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')]} 07:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:33 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 0x1aa0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e570>, '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 0x1d5f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f900>, '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': 'd2a8c569965ab8367867b893000001a1-1467900892.62644-766203591', '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 07:30:33 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 07:30:33 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 07:30:33 INFO - Using env: {'DISPLAY': ':0', 07:30:33 INFO - 'HOME': '/home/cltbld', 07:30:33 INFO - 'LANG': 'en_US.UTF-8', 07:30:33 INFO - 'LANGUAGE': 'en_US:en', 07:30:33 INFO - 'LOGNAME': 'cltbld', 07:30:33 INFO - 'MAIL': '/var/mail/cltbld', 07:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:33 INFO - 'MOZ_NO_REMOTE': '1', 07:30:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:33 INFO - 'NO_EM_RESTART': '1', 07:30:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:33 INFO - 'PWD': '/builds/slave/test', 07:30:33 INFO - 'SHELL': '/bin/bash', 07:30:33 INFO - 'SHLVL': '1', 07:30:33 INFO - 'TERM': 'linux', 07:30:33 INFO - 'TMOUT': '86400', 07:30:33 INFO - 'USER': 'cltbld', 07:30:33 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467900892.62644-766203591', 07:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:33 INFO - '_': '/tools/buildbot/bin/python'} 07:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:30:33 INFO - Running setup.py (path:/tmp/pip-HEixFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:30:33 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)) 07:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:30:33 INFO - Running setup.py (path:/tmp/pip-SHcbTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:30:33 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)) 07:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:30:33 INFO - Running setup.py (path:/tmp/pip-TEmszT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:30:33 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)) 07:30:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:30:34 INFO - Running setup.py (path:/tmp/pip-HDKaIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:30:34 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)) 07:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:30:34 INFO - Running setup.py (path:/tmp/pip-J6u7mQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:30:34 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)) 07:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:30:34 INFO - Running setup.py (path:/tmp/pip-cF1Wll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:30:34 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)) 07:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:30:34 INFO - Running setup.py (path:/tmp/pip-UXDcBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:30:34 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)) 07:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:30:34 INFO - Running setup.py (path:/tmp/pip-cJm6U5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:30:34 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)) 07:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:30:34 INFO - Running setup.py (path:/tmp/pip-3vHS29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:30:34 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)) 07:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:30:34 INFO - Running setup.py (path:/tmp/pip-4ZUeEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:30:34 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)) 07:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:30:34 INFO - Running setup.py (path:/tmp/pip-YBZZAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:30:34 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)) 07:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:30:34 INFO - Running setup.py (path:/tmp/pip-OgdzMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:30:34 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)) 07:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:30:34 INFO - Running setup.py (path:/tmp/pip-341fZx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:30:34 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)) 07:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:30:34 INFO - Running setup.py (path:/tmp/pip-lZ74z4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:30:34 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)) 07:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:34 INFO - Running setup.py (path:/tmp/pip-6LAV21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:30:34 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)) 07:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:30:34 INFO - Running setup.py (path:/tmp/pip-ZtDsaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:30:34 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)) 07:30:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:30:34 INFO - Running setup.py (path:/tmp/pip-adJh3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:30:35 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)) 07:30:35 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)) 07:30:35 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)) 07:30:35 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)) 07:30:35 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)) 07:30:35 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)) 07:30:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:30:35 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 07:30:35 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 07:30:35 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 07:30:35 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 07:30:35 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 07:30:35 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 07:30:36 INFO - Downloading blessings-1.6.tar.gz 07:30:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:30:37 INFO - Installing collected packages: blessings 07:30:37 INFO - Running setup.py install for blessings 07:30:37 INFO - Successfully installed blessings 07:30:37 INFO - Cleaning up... 07:30:37 INFO - Return code: 0 07:30:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:30:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:30:37 INFO - Reading from file tmpfile_stdout 07:30:37 INFO - Current package versions: 07:30:37 INFO - argparse == 1.2.1 07:30:37 INFO - blessings == 1.6 07:30:37 INFO - blobuploader == 1.2.4 07:30:37 INFO - docopt == 0.6.1 07:30:37 INFO - functools32 == 3.2.3-2 07:30:37 INFO - jsonschema == 2.5.1 07:30:37 INFO - manifestparser == 1.1 07:30:37 INFO - mozInstall == 1.12 07:30:37 INFO - mozcrash == 0.17 07:30:37 INFO - mozdebug == 0.1 07:30:37 INFO - mozdevice == 0.48 07:30:37 INFO - mozfile == 1.2 07:30:37 INFO - mozhttpd == 0.7 07:30:37 INFO - mozinfo == 0.9 07:30:37 INFO - mozleak == 0.1 07:30:37 INFO - mozlog == 3.2 07:30:37 INFO - moznetwork == 0.27 07:30:37 INFO - mozprocess == 0.23 07:30:37 INFO - mozprofile == 0.28 07:30:37 INFO - mozrunner == 6.12 07:30:37 INFO - mozscreenshot == 0.1 07:30:37 INFO - mozsystemmonitor == 0.3 07:30:37 INFO - moztest == 0.7 07:30:37 INFO - mozversion == 1.4 07:30:37 INFO - psutil == 3.1.1 07:30:37 INFO - requests == 1.2.3 07:30:37 INFO - wsgiref == 0.1.2 07:30:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:37 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 0x1aa0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e570>, '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 0x1d5f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f900>, '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': 'd2a8c569965ab8367867b893000001a1-1467900892.62644-766203591', '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 07:30:37 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 07:30:37 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 07:30:37 INFO - Using env: {'DISPLAY': ':0', 07:30:37 INFO - 'HOME': '/home/cltbld', 07:30:37 INFO - 'LANG': 'en_US.UTF-8', 07:30:37 INFO - 'LANGUAGE': 'en_US:en', 07:30:37 INFO - 'LOGNAME': 'cltbld', 07:30:37 INFO - 'MAIL': '/var/mail/cltbld', 07:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:37 INFO - 'MOZ_NO_REMOTE': '1', 07:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:37 INFO - 'NO_EM_RESTART': '1', 07:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:37 INFO - 'PWD': '/builds/slave/test', 07:30:37 INFO - 'SHELL': '/bin/bash', 07:30:37 INFO - 'SHLVL': '1', 07:30:37 INFO - 'TERM': 'linux', 07:30:37 INFO - 'TMOUT': '86400', 07:30:37 INFO - 'USER': 'cltbld', 07:30:37 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467900892.62644-766203591', 07:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:37 INFO - '_': '/tools/buildbot/bin/python'} 07:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:37 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)) 07:30:37 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)) 07:30:37 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)) 07:30:37 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)) 07:30:37 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)) 07:30:37 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)) 07:30:37 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)) 07:30:37 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)) 07:30:37 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)) 07:30:37 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)) 07:30:37 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)) 07:30:37 INFO - Cleaning up... 07:30:37 INFO - Return code: 0 07:30:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:30:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:30:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:30:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:30:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:30:37 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 0x1aa0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c038a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ccf400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5e570>, '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 0x1d5f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f900>, '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': 'd2a8c569965ab8367867b893000001a1-1467900892.62644-766203591', '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 07:30:37 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 07:30:37 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 07:30:37 INFO - Using env: {'DISPLAY': ':0', 07:30:37 INFO - 'HOME': '/home/cltbld', 07:30:37 INFO - 'LANG': 'en_US.UTF-8', 07:30:37 INFO - 'LANGUAGE': 'en_US:en', 07:30:37 INFO - 'LOGNAME': 'cltbld', 07:30:37 INFO - 'MAIL': '/var/mail/cltbld', 07:30:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:37 INFO - 'MOZ_NO_REMOTE': '1', 07:30:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:37 INFO - 'NO_EM_RESTART': '1', 07:30:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:37 INFO - 'PWD': '/builds/slave/test', 07:30:37 INFO - 'SHELL': '/bin/bash', 07:30:37 INFO - 'SHLVL': '1', 07:30:37 INFO - 'TERM': 'linux', 07:30:37 INFO - 'TMOUT': '86400', 07:30:37 INFO - 'USER': 'cltbld', 07:30:37 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467900892.62644-766203591', 07:30:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:37 INFO - '_': '/tools/buildbot/bin/python'} 07:30:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:30:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:30:37 INFO - Cleaning up... 07:30:37 INFO - Return code: 0 07:30:37 INFO - Running post-action listener: _resource_record_post_action 07:30:37 INFO - Running post-action listener: _start_resource_monitoring 07:30:37 INFO - Starting resource monitoring. 07:30:37 INFO - ##### 07:30:37 INFO - ##### Finished create-virtualenv step (success) 07:30:37 INFO - ##### 07:30:37 INFO - ##### 07:30:37 INFO - ##### Running install step. 07:30:37 INFO - ##### 07:30:37 INFO - Running pre-action listener: _resource_record_pre_action 07:30:37 INFO - Running main action method: install 07:30:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:30:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:30:38 INFO - Reading from file tmpfile_stdout 07:30:38 INFO - Detecting whether we're running mozinstall >=1.0... 07:30:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:30:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:30:38 INFO - Reading from file tmpfile_stdout 07:30:38 INFO - Output received: 07:30:38 INFO - Usage: mozinstall [options] installer 07:30:38 INFO - Options: 07:30:38 INFO - -h, --help show this help message and exit 07:30:38 INFO - -d DEST, --destination=DEST 07:30:38 INFO - Directory to install application into. [default: 07:30:38 INFO - "/builds/slave/test"] 07:30:38 INFO - --app=APP Application being installed. [default: firefox] 07:30:38 INFO - mkdir: /builds/slave/test/build/application 07:30:38 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'] 07:30:38 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 07:30:54 INFO - Reading from file tmpfile_stdout 07:30:54 INFO - Output received: 07:30:54 INFO - /builds/slave/test/build/application/firefox/firefox 07:30:54 INFO - Running post-action listener: _resource_record_post_action 07:30:54 INFO - ##### 07:30:54 INFO - ##### Finished install step (success) 07:30:54 INFO - ##### 07:30:54 INFO - ##### 07:30:54 INFO - ##### Running run-tests step. 07:30:54 INFO - ##### 07:30:54 INFO - Running pre-action listener: _resource_record_pre_action 07:30:54 INFO - Running main action method: run_tests 07:30:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:30:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:30:54 INFO - Python 2.7.3 07:30:54 INFO - Return code: 0 07:30:54 INFO - grabbing minidump binary from tooltool 07:30:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 07:30:54 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 0x1d5e570>, '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 0x1d5f470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:30:54 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 07:30:54 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 07:30:54 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 07:30:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:30:54 INFO - Return code: 0 07:30:54 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:30:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:30:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:30:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:30:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:30:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 07:30:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 07:30:54 INFO - Using env: {'DISPLAY': ':0', 07:30:54 INFO - 'HOME': '/home/cltbld', 07:30:54 INFO - 'LANG': 'en_US.UTF-8', 07:30:54 INFO - 'LANGUAGE': 'en_US:en', 07:30:54 INFO - 'LOGNAME': 'cltbld', 07:30:54 INFO - 'MAIL': '/var/mail/cltbld', 07:30:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:30:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:30:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:30:54 INFO - 'MOZ_NO_REMOTE': '1', 07:30:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:30:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:30:54 INFO - 'NO_EM_RESTART': '1', 07:30:54 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:30:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:30:54 INFO - 'PWD': '/builds/slave/test', 07:30:54 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:30:54 INFO - 'SHELL': '/bin/bash', 07:30:54 INFO - 'SHLVL': '1', 07:30:54 INFO - 'TERM': 'linux', 07:30:54 INFO - 'TMOUT': '86400', 07:30:54 INFO - 'USER': 'cltbld', 07:30:54 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1467900892.62644-766203591', 07:30:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:30:54 INFO - '_': '/tools/buildbot/bin/python'} 07:30:54 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 07:30:54 INFO - mozversion application_buildid: 20160707070123 07:30:54 INFO - mozversion application_changeset: ba5ff277a3cd1a7f655f8e02a130a395e8f2a225 07:30:54 INFO - mozversion application_display_name: Nightly 07:30:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:30:54 INFO - mozversion application_name: Firefox 07:30:54 INFO - mozversion application_remotingname: firefox 07:30:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:30:54 INFO - mozversion application_vendor: Mozilla 07:30:54 INFO - mozversion application_version: 50.0a1 07:30:54 INFO - mozversion platform_buildid: 20160707070123 07:30:54 INFO - mozversion platform_changeset: ba5ff277a3cd1a7f655f8e02a130a395e8f2a225 07:30:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:30:54 INFO - mozversion platform_version: 50.0a1 07:30:54 INFO - using testdate: 1467901854 07:30:54 INFO - actual date: 1467901854 07:30:54 INFO - starting webserver on 'localhost:37251' 07:30:54 INFO - SUITE-START | Running 2 tests 07:30:54 INFO - TEST-START | dromaeo_css 07:30:54 INFO - operating with platform_type : linux_ 07:30:54 INFO - Initialising browser for dromaeo_css test... 07:30:54 INFO - TEST-INFO | started process 15571 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7kz0Z3/profile http://localhost:37251/getInfo.html) 07:30:59 INFO - PROCESS | 15571 | __metrics Screen width/height:1600/1200 07:30:59 INFO - PROCESS | 15571 | colorDepth:24 07:30:59 INFO - PROCESS | 15571 | Browser inner width/height: 1024/697 07:30:59 INFO - PROCESS | 15571 | __metrics 07:31:00 ERROR - PROCESS | 15571 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 07:31:01 INFO - TEST-INFO | 15571: exit 0 07:31:01 INFO - Browser initialized. 07:31:01 INFO - Running cycle 1/1 for dromaeo_css test... 07:31:01 INFO - TEST-INFO | started process 15690 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7kz0Z3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:31:13 INFO - PROCESS | 15690 | RSS: Main: 169455616 07:31:13 INFO - PROCESS | 15690 | 07:32:03 INFO - PROCESS | 15690 | 1467901923004 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:34:15 INFO - PROCESS | 15690 | Cycle 1(1): loaded http://localhost:37251/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37251/tests/dromaeo/cssquery-ext.html) 07:34:16 INFO - PROCESS | 15690 | RSS: Main: 171098112 07:34:16 INFO - PROCESS | 15690 | 07:37:18 INFO - PROCESS | 15690 | Cycle 1(1): loaded http://localhost:37251/tests/dromaeo/cssquery-ext.html (next: http://localhost:37251/tests/dromaeo/cssquery-jquery.html) 07:37:19 INFO - PROCESS | 15690 | RSS: Main: 168337408 07:37:19 INFO - PROCESS | 15690 | 07:40:21 INFO - PROCESS | 15690 | Cycle 1(1): loaded http://localhost:37251/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37251/tests/dromaeo/cssquery-mootools.html) 07:40:21 INFO - PROCESS | 15690 | RSS: Main: 170663936 07:40:21 INFO - PROCESS | 15690 | 07:43:23 INFO - PROCESS | 15690 | Cycle 1(1): loaded http://localhost:37251/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37251/tests/dromaeo/cssquery-prototype.html) 07:43:24 INFO - PROCESS | 15690 | RSS: Main: 166907904 07:43:24 INFO - PROCESS | 15690 | 07:46:27 INFO - PROCESS | 15690 | Cycle 1(1): loaded http://localhost:37251/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37251/tests/dromaeo/cssquery-yui.html) 07:46:27 INFO - PROCESS | 15690 | RSS: Main: 168497152 07:46:27 INFO - PROCESS | 15690 | 07:49:30 INFO - PROCESS | 15690 | Cycle 1(1): loaded http://localhost:37251/tests/dromaeo/cssquery-yui.html (next: http://localhost:37251/tests/dromaeo/cssquery-dojo.html) 07:49:30 INFO - PROCESS | 15690 | RSS: Main: 169521152 07:49:30 INFO - PROCESS | 15690 | 07:49:30 INFO - PROCESS | 15690 | __start_tp_report 07:49:30 INFO - PROCESS | 15690 | _x_x_mozilla_page_load 07:49:30 INFO - PROCESS | 15690 | _x_x_mozilla_page_load_details 07:49:30 INFO - PROCESS | 15690 | |i|pagename|runs| 07:49:30 INFO - PROCESS | 15690 | |0;dojo.html;2587.3531617095728;2615.6991945926225;2630.3687115092384;2646.0738741440487;2652.018753061366;4734.739589322586;4774.952250477494;4791.760411979404;4816.542428469299;4845.58812500937;4646.210144275473;4741.288806679;4745.193317136086;4750.382450281467;4764.952350476494;4326.264535029045;4421.358902959069;4423.800928958189;4455.977720111395;4471.105778844228;4461.866144015668;4522.547745225484;4530.161920044786;4535.523770004152;4563.885902852422;4276.358546218076;4359.760213188273;4364.41080454141;4381.101874115799;4385.2106620808245;4339.240632889232;4424.40270563473;4426.070525189714;4433.9556604433865;4438.112377524476;4366.039471316337;4402.955970440286;4421.358902959053;4421.425214722098;4453.421055262827;4741.122892264908;4815.66290359675;4829.468758436569;4836.395450568679;4864.2217245240945;5139.408967968657;5141.048905952411;5146.7683954221775;5168.8966220675375;5191.117510023305;5056.974715126401;5115.897682046376;5121.539061484447;5125.589952803767;5150.690958542499;4762.761681962715;4775.379200703921;4783.282507623884;4784.66507344486;4788.377510923628;5229.189475631283;5241.42344342122;5243.68537887728;5251.793204437746;5266.657667251617;4972.602191824718;4986.626003049786;4997.825076122391;5040.722760248222;5050.393952725696;4995.275685025651;5043.394792624835;5096.898062038738;5118.10433174193;5186.066508028591;4960.553550180501;5059.747012649353;5064.974675126601;5077.136886729265;5086.872828179326;5005.699658020458;5010.974945125251;5057.190849464068;5078.390593128848;5083.313752643419;4267.786610669516;4281.186574550826;4292.163028209532;4320.697551171388;4325.307950727868;3683.226522430266;3683.834227459771;3723.553173619183;3745.1198968242443;3798.7910664913693;4413.7351758894565;4445.466544014739;4464.665150113755;4474.530174331713;4489.483709373464;5116;5123.129068058439;5159.974200129051;5167.870803229875;5172.224166374998;4341.60925516705;4377.802998865059;4416.271315233015;4456.7548784817145;4504.887377815516;4551.180787458223;4576.061907308994;4577.153226653079;4616.884577885579;4630.6758526902795;4786.329913812069;4794.849236183221;4795.184818580849;4796.688215265996;4853.733044682576;4988.900221995613;5119.692818430906;5127.333446651912;5158.948410515847;5185.248139019896;4816.8073277069925;4838.443578988461;4855.872408865163;4858.611311095033;4902.730349830794;5090.872728181825;5104.69371837691;5110.9488905110475;5111.182210846247;5144.485551444825;4963.131451995959;5037.471065538066;5104.2343648453025;5124.410692770379;5174.990876778992;4954.677945933503;4954.900901982012;4954.900901982012;5006.49935006511;5013.273075403973;5032.194848824171;5032.924506132485;5035.672681275705;5059.822906198266;5079.619028572798;4713.835015774432;4843.104025755247;4866.537678920497;4959.851204463872;4974.204127339608;5019.0965626187635;5043.621728370314;5043.798248070183;5045.217991211368;5081.263216833612;4943.233798761198;4945.505449455026;4949.084419382426;4951.207806750903;4978.676386035041 07:49:30 INFO - PROCESS | 15690 | |1;ext.html;530.8646295194725;534.8288547664744;563.2255648483335;576.6482445708118;578.4186892173365;39980;41478.17043659125;41517;41522.37716434252;45142;41262;41341.586584134224;41758.37362439566;41821;41827.372589411105;7753.844923101535;7864.449488535804;7867.881981770278;7885.250901164409;7888.408369372291;7726.806829829243;7847.332976696959;7848.4113691473085;7883;7885;7834.529928204298;7841.059072911258;7924.405669574776;7964.283214510722;7971.641276142587;7781.805454863617;7868.409869259771;7869.685212591489;7874.212578742137;7878.4485086044;7748.7675369739;7762;7831.256030677134;7834.4907581007055;7863.410244231705;38932;39393.40909886354;39483.60516394857;39705.60294397048;39783;3044.284593120637;3182.45898197307;3217.6460589335156;3288.7862288951383;3579.4451859961487;29357;29531.70468295311;29645.329800794865;29832;30214.69785302163;3019.048999565152;3027.9394412111633;3048.6189226346705;3057.877684892602;3101.7518598512065;251675;252355;252651;253138;253676;31891.840540797613;33125.17187070342;50901.49098508967;51393.229101563506;51739;34038.319233615686;34229.828850855585;34344.14139646529;34464.82767586146;34478.82760586181;13806.17162970225;13956.720865582834;13958.441662333596;13961.232132232824;13994.090384125;11376.488058037243;11398.031167350702;11467.483963221675;11491.77016459666;11498.080153587693;7938.975561231849;7993.960030199812;8007.639656215484;8011.359091272684;8097.797555061053;3124.4063627910623;3136.8431578420987;3150.763692723055;3154.495280755068;3200.9839950800097;908.8727578138934;914.2548822709471;942.8444306689456;945.935822200025;1058.4496062047692;28545.28636784097;28604.570931436047;28634.713652863622;28998;29306.413871722445;891.3136884598823;993.3940296419179;1012.6202673997251;1026.7484466305652;1061.3154515337565;15200.467983620742;15316.621504064688;15471.845281547041;15493.380264789508;15679.294431750599;361293;365160;366220;366491;368434.5252379803;48696;48936;48948.26577601339;49148.508514915105;49299.50700493021;1152.2683096233952;1188.037689471531;1197.287613869746;1211.273236058358;1214.878512148778;26998.595021074307;28192;28276.953766604674;28353.858230708713;28403.857980709963;42046;42661;42792;42985.355219672354;43025;314633;315846;316762;317734;317815;24859.254222373358;24985.125520606693;25262.621060683738;25445.87277063603;25535;42259;42402.575974239866;42810.78594607007;43256.13487730165;43358.13283734245;37029.587205961;37489.4376584346;37622.43566346452;37624.43563346497;38167.42748858825;36701.44947825732;37454.62545374512;37600;37691.81154094212;37943.81028094842;31351.529727054567;35434.645653543135;36149.27701446009;36732.081697956695;36882.26235475329;32328;33432.83283583567;33446.33107337791;33520.83239583787;34064.65935340714;25363.6195457072;25630.487390251717;25821.225363239133;26039.218823435327;26052.609210861472 07:49:30 INFO - PROCESS | 15690 | |2;jquery.html;369.0312928562523;369.4882587616151;372.8657683234036;380.1143336027057;385.4565063260803;16315.184240787958;16966;17808.910955445237;17858.107094645264;18007.279708811664;10661.200409969244;15952.361905523794;16825.91587042063;16841;17482.38811641593;4608.377868987685;4691.085238378518;4786.162421576228;4794;4803.495632958541;3472.2361080562237;5213.6089793265655;5490.505854473096;5498.670079795225;5565;5467.45325467454;5518.448155184489;5519.282493275889;5526.281583394173;5547.417521160281;5958.136070269787;6106.755729770804;6130.724117414727;6131.202943617323;6146.0473626587955;4533.546645335473;4844.442889067767;5393.811216607439;5406.107992181285;5428.37573679028;12158.5744498943;12347.691307717289;12390.504379824797;12518.248905065726;12612.243265404106;1816.8455681267108;1863.9813601863943;1972.3589833304234;2134.8398870084807;2418.6855708757926;9303.953480232556;9411.388259763093;9554.665586704501;11023.393713345762;13528.188308701509;1732.6967780638338;1866.3840932492244;1973.062795172296;1985.2753744883014;2017.4149496645955;71023.64488177525;71070;71339.28660713378;72083.27916720818;74430.62784686097;9903.702888913343;10003.24975626831;10110.949445252874;10115.7471063224;10203.897961020442;13174.341282935815;13318.067735258439;13352.332383380792;13428.597142085753;13436.261005644783;7705.499142555716;7734.2265773422205;7751.92248077512;7840.882386764203;7906.723264685708;7642.847143057108;7735.265149810759;7800.336971357385;7825.060992680801;7864;4198.391233271159;4318.632916202158;4321.632661223768;4438.689291749546;4461.5092339842595;1612.4275882061934;1670.158635139175;1771.9822801772075;1806.7109262517934;1855.4897403214225;716.2872941423317;825.2119226139023;859.3426029087752;879.6041781198486;901.0493928904937;15840.524784256491;17104.315827366765;17170.570735731708;17718.379856704953;17769.28922843098;836.6946064686467;870.6169285514353;872.289084396215;885.8449771289999;890.8218356328631;8318.960129983752;9620.567074481665;9687.370320929118;9732.610695572239;9756.560954757053;371631;372281;372531;381348;390633;86805.56597216973;90985;92412;92464;94048;842.6924172676929;881.1937077573948;890.4479222881855;949.4540639132526;950.1686024728501;13233.404496797475;15671.294791734172;16282.918585406996;16413.67172656564;16539;38897.80551097226;39053;39070.80464597659;39231.6076839228;39340.803295983336;49414.75292623514;53267.46732532625;53282.20076698775;53590.464095360105;53736.462635373144;7509.624518774149;7562.584057876869;7743.032120984877;7781.9610901945125;7819.960900195462;10732.946335268585;11257.039390659162;11394.430278485877;11588.478518466858;11696.122790790554;10256.487175641338;10389.480525973822;10555;10557.788844223227;10702.304350217211;10017.599296028076;10022.398656080659;10184.490775461345;10198.796024079626;10280.948595256976;9458.196053335543;10167.491625418552;10182;10194;10278.17774578017;7561;7585.355244804033;7645.579493127709;7660.2722741339485;7660.961695191489;9274.907250927405;9324.207442367204;9969;10181.592736290762;10209.38743675382 07:49:30 INFO - PROCESS | 15690 | |3;mootools.html;1390.993045034775;1444.8771854392378;1494.6114010357303;1717.0985232752803;1725.2236493577877;6880.621565813878;7343.522671026386;7547.5471471711735;7856.8428631427405;7864.252895974881;7628.694852205919;7783.221677832214;7913.406494512906;7919.604019799016;7920.564368959705;2208.02846747431;2231.040652519416;2232.2521955145044;2245.86524808512;2246.0903334149693;2180.8800515971616;2202.5044365017825;2237.552489502098;2255.4812393149587;2258.2434884313775;2206.249875042485;2223.144089525528;2231.6540936154843;2233.765454627265;2258.2096266306744;2153.6661817418326;2173.217641649005;2180.8473406861526;2184.868907865533;2189.824814014875;2165.317924853666;2177.520945392011;2178.2593918067773;2179.2808373236794;2186.650135978236;7942.602869856484;7953.562554059525;8018.0779210390965;8021.157778433298;8048.758537243892;4637.304404339376;4746.762661866893;4762.38089048425;4766.618670506351;4767.976160119212;2810.7076450854397;2890.2918784897624;2911.5195992661183;2913.8397388143644;2939.6619388770137;890.7416849113749;907.120093509295;912.3157631776168;917.8439665256856;932.3799673217302;10665.52005159762;10698.732531686692;10738.892611073867;10748.570057197703;10784.622538211124;4092.1611069730634;4193.51774545925;4293.368519962394;4299.419578356944;4343.19650864591;9158.95420522893;9191.172794448532;9231;9241.768955776159;9261.49061801594;4701.694389864648;4745.430548334153;4750.144973904661;4756.571908528249;4765.4996225395835;3517.7889326640484;4184.874453766331;4300.333448315516;4306.698531102856;4338.154059958278;3665.157013886821;3726.4410338449447;3731.533558305212;3774.9056273592832;3831.923361532754;1217.5981925964588;1243.3348158735034;1245.2590708528412;1245.7633049720705;1252.6680429686141;652.9183852018498;733.7872017114977;813.6785969541997;817.5896578402209;834.5368320582014;5229.635596127791;5266.236395722599;5341.706206158621;5454.481824226692;5477.972610137003;409.9403043133474;411.5822440223176;413.7827640488707;435.8561674647359;437.84675363623114;3510.490489089665;3513.0690367052753;3528.8588456461966;3576.8926932192076;3591.6408359164398;9111.498867562215;9421.38760980534;9422.670206542738;9427.198688111588;9431.245500359955;9279.211267042241;9355.251579873593;9370.39092458988;9370.85943710845;9375.671851485165;7083.583283343352;7171.713131474787;7174.892376614355;7190.209077001526;7195.784126476214;4934.5805606523845;5062.898742025065;5070.923936141035;5109.182530795055;5214.97392513035;8771.429857059271;8773.780655483664;8806.515641639771;8838.64645414202;8889.911100888909;8801.779955501164;8920.509371984603;8924;8955.149260820212;8960.327975402;5786.33457152416;6518.511111666549;6754.324567543206;6773.559718618274;6820.045193672989;7568.508046976929;7572.583507907118;7636.274553917369;7637.465377423527;7641.656125474478;6628.668566571749;6737.66311684404;6773.356531129535;6944.791656250321;7085;6920.5847649141215;6928.792136235921;6936.618485983117;6978.755743548952;7010.579365238102;5669.149627555899;5695;5727.284089488814;5746.540276777764;5791.0734282514595;4288.592583704543;4306.4832220133785;4393.62654174386;4398.956010439854;4420.425344705168;4423.071155057474;4486.887827804331;4495.505494395548;4546.704464209815;4558.222293305547 07:49:30 INFO - PROCESS | 15690 | |4;prototype.html;300.9623797025372;301.74502545349173;303.0242618767569;305.5111821086261;306.78371747917714;4998.475160108186;5069;5166.612504062192;5168.095583272931;5179.187284450445;5035.295058691786;5045.091883460976;5058.266551350052;5073.264376665381;5126.461721519243;3712.6658600725927;3817.3701339279123;3922.901587555489;3960.7425517341353;3978.38335058065;3908.7654740715507;3910.432987216852;3912.4131380293043;3918.6277303656107;3940.8226629801584;3911;3912.7697212588837;3919;3929.646331830135;3947.50656167979;3853.903652408684;3929.4302326162688;3940.192260586573;3946.48695669564;3957.8021098944937;3408.9829550852087;3410.454327307644;3416.282580658065;3417.9658203418144;3436.467347561132;4965.801367945278;4972.676776009584;4981.950180498185;4988.87527811804;5013.824516141917;4450.287953927356;4457.977710111461;4476.574725401082;4482;4500.0874628282845;5110.616703747234;5295.511109778437;5301.8866038131655;5312.335958005249;5337.2527846101575;3740.6446387593137;3759.830807613664;3761.811909404546;3763.1909139535132;3763.8870833875026;5600.487868275583;5620.325560932673;5639.210510528529;5661.660300381949;5671.914921276184;3682.59491455945;3740.738148329591;3752.981235093807;3772.773633581994;3791.75353602015;3796.6013568575454;3804.6956243500454;3818.3890577507464;3820.9235815283537;3821.541415030214;4405.691601587858;4407.515173330931;4421.270490369053;4424.469063712375;4442.378067070613;5238.60710446718;5322.121849894724;5327.174287985368;5349.973250133802;5359.410464848864;1328.362386054699;1329.940152693131;1346.299924039494;1357.3281225793098;1357.4909408971635;817.0032560276453;836.9121242269474;837.6188834080479;856.2764464027887;857.4683696108452;4125.339945608688;4448.822047118144;4561.68068235227;4693.319468677091;4709.246520556763;5447.291852059207;5479.561635069185;5503.532199763065;5504.2294078829;5508.7521061552325;4630.884227894262;4672.649551283667;4685.250359942393;4685.320628508915;4690.296455531629;2761.9447611047667;2880.4095160492047;2899.869505872241;2913.7814663900294;2932.310906936868;5085.364329458817;5102.3877134743325;5141.9432227109455;5149.536541711264;5169.922451163236;5489.2589500417735;5554.389017208185;5599.972000139973;5643.746031428595;5662.66024038559;5098.515641014098;5109.923351149736;5126.1798112302595;5170.638055336166;5170.8965820684125;5492.534927746918;5510.862228444321;5517.255170552085;5526.281583394133;5546.168074788814;5192.273081768631;5385.75764090609;5402.027635025733;5405.432429594836;5412.215228791724;5135.409427915837;5147.246223270532;5157;5165.431802501797;5165.586753059822;3802.391617341212;3814.4278358245374;3824.94262586067;3834.2523207974177;3840.6543411093135;5226.503482169188;5325.334333208349;5455.208994695826;5516.282883225315;5526.8393637335;5192.896142077062;5201.843944681666;5230.503102205284;5245.947540524546;5268.315119034501;5276.498732620395;5286.312779338815;5291.708956007456;5299.49654782795;5300.549453296513;5054.873628159326;5265.2891859599995;5274.815381461631;5281.287026251561;5284.233786101071;5123.540700463873;5166.922496162485;5278.208268759717;5391.568674506108;5399.325084364455;5236.869078273074;5239.711815850165;5262.131943160123;5265.763040663102;5269.947300527099 07:49:30 INFO - PROCESS | 15690 | |5;yui.html;612.2255346986063;659.5712786688651;667.4326822201128;683.4976292425064;751.9360854327382;12798.540386139637;12824.935875320622;13294;13301.06892517523;13622.318884055807;12555.435005424755;12565.623031309053;12627.36863156843;12645.304508252066;12669.23984560927;620.1875543038634;775.6974779835855;803.1366281247653;803.6504120707482;804.0753133896008;770.7263921307939;789.9802504937365;790.4387884601939;790.5572879187673;791.0507391130666;833.62903507939;833.8540755367817;834.7120243515977;838.1995194589152;838.2832678060262;825.6573521988398;826.7395770332356;827.2472050434106;830.6179157587517;834.0575150080431;604.8276241271261;608.6500262349123;609.3114780298279;609.7012463892705;613.772904025509;13167.736645267041;13186.538471153559;13192.538261160813;13196.14225075367;13261.46954121834;13519.729605407836;13962.58112256634;13989.160650361011;14009.71980560383;14212.928935355361;10009;10140.797184056277;10214.233932455096;10712.517936692868;10822;4108.958910410887;4130;4131.566185550504;4167.499900012018;4237.6821738369745;59451.405485945455;59606.70196648989;60298.69850650762;60331.69834150845;60763.392366076216;10223.642172523925;10253.692389228336;10302.072813446675;10313.432761198055;10332.483375831329;18079.909600451912;18166.545836353933;18263.817361826477;18282.725759113622;18289.176987035615;6577.3422657733845;6685.0640910272605;6739;6764.4926630502905;6771.559848609824;3664.578573464086;3699.3896007159055;3706.666400023957;3733.309337772521;3768.1144930941205;2732.53546897028;2823.9858800705865;2827.7596404305455;2834.6598408190735;2842.7725781937397;512.7846304552022;514.2800079888111;523.1995047577213;525.4430303877901;531.665051017864;483.3981692792496;506.60231718101113;573.4494884910449;574.635106707244;576.3026737647493;7666.8849967250535;7943.364530837634;9010.144036316671;9038.141376569216;9171.541422928827;513.0406140517257;596.8567543789459;609.3297372889785;622.1445512420422;629.5089829932659;3879.8642047528765;3973.245083434196;3986.262541429845;4067.3695577185586;4100.1691913445175;62867;95465;95652.52173739087;96409.51795241119;98578;25414.745852541608;25564;43793;79256.20743792603;81158;65893.67053164703;73676;74193.62903185449;76093.6195319031;76842;7557.886631700639;7565;7593.957368300885;7811.179826118403;7837.921620783947;41789;42212.1557568853;42297.462152270964;42355;42840.35739463973;59812.700936495035;63893.68053159704;64008.67995660178;64664;64837.351626483134;9973.451460169761;10059.159830971912;10285.382877027403;10451.895481045092;10635.840462393226;11239.943800280946;11656.650300491;11806.763864722485;12575.748485030432;12875.420606072936;11189.832152517556;11658.76682466329;11995.340256285988;12126.696832579257;12204.938975305422;12496.87503124957;12507.333565355813;12514.31171285588;12887.033472489413;12942.80585791195;11071.699015583445;11319.377434241196;11348.092152627934;11384.715382115513;11558.364289964133;10573.9471302643;10588.205884558844;10749.032587067202;10760.3543787373;10786.191035672513;9738.659146929824;9855.35940163887;9900.455474948947;10059.736559274397;10155.39067655943 07:49:30 INFO - PROCESS | 15690 | __end_tp_report 07:49:30 INFO - PROCESS | 15690 | __start_cc_report 07:49:30 INFO - PROCESS | 15690 | _x_x_mozilla_cycle_collect,407 07:49:30 INFO - PROCESS | 15690 | __end_cc_report 07:49:30 INFO - PROCESS | 15690 | __startTimestamp1467902970757__endTimestamp 07:49:30 INFO - PROCESS | 15690 | 07:49:30 INFO - PROCESS | 15690 | ------- Summary: start ------- 07:49:30 INFO - PROCESS | 15690 | Number of tests: 6 07:49:30 INFO - PROCESS | 15690 | 07:49:30 INFO - PROCESS | 15690 | [#0] dojo.html Cycles:165 Average:4729.82 Median:4853.73 stddev:503.37 (10.4%) stddev-sans-first:476.03 07:49:30 INFO - PROCESS | 15690 | Values: 2587.4 2615.7 2630.4 2646.1 2652.0 4734.7 4775.0 4791.8 4816.5 4845.6 4646.2 4741.3 4745.2 4750.4 4765.0 4326.3 4421.4 4423.8 4456.0 4471.1 4461.9 4522.5 4530.2 4535.5 4563.9 4276.4 4359.8 4364.4 4381.1 4385.2 4339.2 4424.4 4426.1 4434.0 4438.1 4366.0 4403.0 4421.4 4421.4 4453.4 4741.1 4815.7 4829.5 4836.4 4864.2 5139.4 5141.0 5146.8 5168.9 5191.1 5057.0 5115.9 5121.5 5125.6 5150.7 4762.8 4775.4 4783.3 4784.7 4788.4 5229.2 5241.4 5243.7 5251.8 5266.7 4972.6 4986.6 4997.8 5040.7 5050.4 4995.3 5043.4 5096.9 5118.1 5186.1 4960.6 5059.7 5065.0 5077.1 5086.9 5005.7 5011.0 5057.2 5078.4 5083.3 4267.8 4281.2 4292.2 4320.7 4325.3 3683.2 3683.8 3723.6 3745.1 3798.8 4413.7 4445.5 4464.7 4474.5 4489.5 5116.0 5123.1 5160.0 5167.9 5172.2 4341.6 4377.8 4416.3 4456.8 4504.9 4551.2 4576.1 4577.2 4616.9 4630.7 4786.3 4794.8 4795.2 4796.7 4853.7 4988.9 5119.7 5127.3 5158.9 5185.2 4816.8 4838.4 4855.9 4858.6 4902.7 5090.9 5104.7 5110.9 5111.2 5144.5 4963.1 5037.5 5104.2 5124.4 5175.0 4954.7 4954.9 4954.9 5006.5 5013.3 5032.2 5032.9 5035.7 5059.8 5079.6 4713.8 4843.1 4866.5 4959.9 4974.2 5019.1 5043.6 5043.8 5045.2 5081.3 4943.2 4945.5 4949.1 4951.2 4978.7 07:49:30 INFO - PROCESS | 15690 | 07:49:30 INFO - PROCESS | 15690 | [#1] ext.html Cycles:180 Average:45915.98 Median:365690.00 stddev:82898.24 (22.7%) stddev-sans-first:83060.76 07:49:30 INFO - PROCESS | 15690 | Values: 530.9 534.8 563.2 576.6 578.4 39980.0 41478.2 41517.0 41522.4 45142.0 41262.0 41341.6 41758.4 41821.0 41827.4 7753.8 7864.4 7867.9 7885.3 7888.4 7726.8 7847.3 7848.4 7883.0 7885.0 7834.5 7841.1 7924.4 7964.3 7971.6 7781.8 7868.4 7869.7 7874.2 7878.4 7748.8 7762.0 7831.3 7834.5 7863.4 38932.0 39393.4 39483.6 39705.6 39783.0 3044.3 3182.5 3217.6 3288.8 3579.4 29357.0 29531.7 29645.3 29832.0 30214.7 3019.0 3027.9 3048.6 3057.9 3101.8 251675.0 252355.0 252651.0 253138.0 253676.0 31891.8 33125.2 50901.5 51393.2 51739.0 34038.3 34229.8 34344.1 34464.8 34478.8 13806.2 13956.7 13958.4 13961.2 13994.1 11376.5 11398.0 11467.5 11491.8 11498.1 7939.0 7994.0 8007.6 8011.4 8097.8 3124.4 3136.8 3150.8 3154.5 3201.0 908.9 914.3 942.8 945.9 1058.4 28545.3 28604.6 28634.7 28998.0 29306.4 891.3 993.4 1012.6 1026.7 1061.3 15200.5 15316.6 15471.8 15493.4 15679.3 361293.0 365160.0 366220.0 366491.0 368434.5 48696.0 48936.0 48948.3 49148.5 49299.5 1152.3 1188.0 1197.3 1211.3 1214.9 26998.6 28192.0 28277.0 28353.9 28403.9 42046.0 42661.0 42792.0 42985.4 43025.0 314633.0 315846.0 316762.0 317734.0 317815.0 24859.3 24985.1 25262.6 25445.9 25535.0 42259.0 42402.6 42810.8 43256.1 43358.1 37029.6 37489.4 37622.4 37624.4 38167.4 36701.4 37454.6 37600.0 37691.8 37943.8 31351.5 35434.6 36149.3 36732.1 36882.3 32328.0 33432.8 33446.3 33520.8 34064.7 25363.6 25630.5 25821.2 26039.2 26052.6 07:49:30 INFO - PROCESS | 15690 | 07:49:30 INFO - PROCESS | 15690 | [#2] jquery.html Cycles:180 Average:24347.79 Median:4380.16 stddev:62952.82 (1437.2%) stddev-sans-first:63103.68 07:49:30 INFO - PROCESS | 15690 | Values: 369.0 369.5 372.9 380.1 385.5 16315.2 16966.0 17808.9 17858.1 18007.3 10661.2 15952.4 16825.9 16841.0 17482.4 4608.4 4691.1 4786.2 4794.0 4803.5 3472.2 5213.6 5490.5 5498.7 5565.0 5467.5 5518.4 5519.3 5526.3 5547.4 5958.1 6106.8 6130.7 6131.2 6146.0 4533.5 4844.4 5393.8 5406.1 5428.4 12158.6 12347.7 12390.5 12518.2 12612.2 1816.8 1864.0 1972.4 2134.8 2418.7 9304.0 9411.4 9554.7 11023.4 13528.2 1732.7 1866.4 1973.1 1985.3 2017.4 71023.6 71070.0 71339.3 72083.3 74430.6 9903.7 10003.2 10110.9 10115.7 10203.9 13174.3 13318.1 13352.3 13428.6 13436.3 7705.5 7734.2 7751.9 7840.9 7906.7 7642.8 7735.3 7800.3 7825.1 7864.0 4198.4 4318.6 4321.6 4438.7 4461.5 1612.4 1670.2 1772.0 1806.7 1855.5 716.3 825.2 859.3 879.6 901.0 15840.5 17104.3 17170.6 17718.4 17769.3 836.7 870.6 872.3 885.8 890.8 8319.0 9620.6 9687.4 9732.6 9756.6 371631.0 372281.0 372531.0 381348.0 390633.0 86805.6 90985.0 92412.0 92464.0 94048.0 842.7 881.2 890.4 949.5 950.2 13233.4 15671.3 16282.9 16413.7 16539.0 38897.8 39053.0 39070.8 39231.6 39340.8 49414.8 53267.5 53282.2 53590.5 53736.5 7509.6 7562.6 7743.0 7782.0 7820.0 10732.9 11257.0 11394.4 11588.5 11696.1 10256.5 10389.5 10555.0 10557.8 10702.3 10017.6 10022.4 10184.5 10198.8 10280.9 9458.2 10167.5 10182.0 10194.0 10278.2 7561.0 7585.4 7645.6 7660.3 7661.0 9274.9 9324.2 9969.0 10181.6 10209.4 07:49:30 INFO - PROCESS | 15690 | 07:49:30 INFO - PROCESS | 15690 | [#3] mootools.html Cycles:180 Average:5105.88 Median:4998.74 stddev:2866.83 (57.4%) stddev-sans-first:2861.28 07:49:30 INFO - PROCESS | 15690 | Values: 1391.0 1444.9 1494.6 1717.1 1725.2 6880.6 7343.5 7547.5 7856.8 7864.3 7628.7 7783.2 7913.4 7919.6 7920.6 2208.0 2231.0 2232.3 2245.9 2246.1 2180.9 2202.5 2237.6 2255.5 2258.2 2206.2 2223.1 2231.7 2233.8 2258.2 2153.7 2173.2 2180.8 2184.9 2189.8 2165.3 2177.5 2178.3 2179.3 2186.7 7942.6 7953.6 8018.1 8021.2 8048.8 4637.3 4746.8 4762.4 4766.6 4768.0 2810.7 2890.3 2911.5 2913.8 2939.7 890.7 907.1 912.3 917.8 932.4 10665.5 10698.7 10738.9 10748.6 10784.6 4092.2 4193.5 4293.4 4299.4 4343.2 9159.0 9191.2 9231.0 9241.8 9261.5 4701.7 4745.4 4750.1 4756.6 4765.5 3517.8 4184.9 4300.3 4306.7 4338.2 3665.2 3726.4 3731.5 3774.9 3831.9 1217.6 1243.3 1245.3 1245.8 1252.7 652.9 733.8 813.7 817.6 834.5 5229.6 5266.2 5341.7 5454.5 5478.0 409.9 411.6 413.8 435.9 437.8 3510.5 3513.1 3528.9 3576.9 3591.6 9111.5 9421.4 9422.7 9427.2 9431.2 9279.2 9355.3 9370.4 9370.9 9375.7 7083.6 7171.7 7174.9 7190.2 7195.8 4934.6 5062.9 5070.9 5109.2 5215.0 8771.4 8773.8 8806.5 8838.6 8889.9 8801.8 8920.5 8924.0 8955.1 8960.3 5786.3 6518.5 6754.3 6773.6 6820.0 7568.5 7572.6 7636.3 7637.5 7641.7 6628.7 6737.7 6773.4 6944.8 7085.0 6920.6 6928.8 6936.6 6978.8 7010.6 5669.1 5695.0 5727.3 5746.5 5791.1 4288.6 4306.5 4393.6 4399.0 4420.4 4423.1 4486.9 4495.5 4546.7 4558.2 07:49:30 INFO - PROCESS | 15690 | 07:49:30 INFO - PROCESS | 15690 | [#4] prototype.html Cycles:180 Average:4391.90 Median:5071.13 stddev:1297.78 (25.6%) stddev-sans-first:1264.57 07:49:30 INFO - PROCESS | 15690 | Values: 301.0 301.7 303.0 305.5 306.8 4998.5 5069.0 5166.6 5168.1 5179.2 5035.3 5045.1 5058.3 5073.3 5126.5 3712.7 3817.4 3922.9 3960.7 3978.4 3908.8 3910.4 3912.4 3918.6 3940.8 3911.0 3912.8 3919.0 3929.6 3947.5 3853.9 3929.4 3940.2 3946.5 3957.8 3409.0 3410.5 3416.3 3418.0 3436.5 4965.8 4972.7 4982.0 4988.9 5013.8 4450.3 4458.0 4476.6 4482.0 4500.1 5110.6 5295.5 5301.9 5312.3 5337.3 3740.6 3759.8 3761.8 3763.2 3763.9 5600.5 5620.3 5639.2 5661.7 5671.9 3682.6 3740.7 3753.0 3772.8 3791.8 3796.6 3804.7 3818.4 3820.9 3821.5 4405.7 4407.5 4421.3 4424.5 4442.4 5238.6 5322.1 5327.2 5350.0 5359.4 1328.4 1329.9 1346.3 1357.3 1357.5 817.0 836.9 837.6 856.3 857.5 4125.3 4448.8 4561.7 4693.3 4709.2 5447.3 5479.6 5503.5 5504.2 5508.8 4630.9 4672.6 4685.3 4685.3 4690.3 2761.9 2880.4 2899.9 2913.8 2932.3 5085.4 5102.4 5141.9 5149.5 5169.9 5489.3 5554.4 5600.0 5643.7 5662.7 5098.5 5109.9 5126.2 5170.6 5170.9 5492.5 5510.9 5517.3 5526.3 5546.2 5192.3 5385.8 5402.0 5405.4 5412.2 5135.4 5147.2 5157.0 5165.4 5165.6 3802.4 3814.4 3824.9 3834.3 3840.7 5226.5 5325.3 5455.2 5516.3 5526.8 5192.9 5201.8 5230.5 5245.9 5268.3 5276.5 5286.3 5291.7 5299.5 5300.5 5054.9 5265.3 5274.8 5281.3 5284.2 5123.5 5166.9 5278.2 5391.6 5399.3 5236.9 5239.7 5262.1 5265.8 5269.9 07:49:30 INFO - PROCESS | 15690 | 07:49:30 INFO - PROCESS | 15690 | [#5] yui.html Cycles:180 Average:16510.49 Median:23296.34 stddev:22945.77 (98.5%) stddev-sans-first:22979.08 07:49:30 INFO - PROCESS | 15690 | Values: 612.2 659.6 667.4 683.5 751.9 12798.5 12824.9 13294.0 13301.1 13622.3 12555.4 12565.6 12627.4 12645.3 12669.2 620.2 775.7 803.1 803.7 804.1 770.7 790.0 790.4 790.6 791.1 833.6 833.9 834.7 838.2 838.3 825.7 826.7 827.2 830.6 834.1 604.8 608.7 609.3 609.7 613.8 13167.7 13186.5 13192.5 13196.1 13261.5 13519.7 13962.6 13989.2 14009.7 14212.9 10009.0 10140.8 10214.2 10712.5 10822.0 4109.0 4130.0 4131.6 4167.5 4237.7 59451.4 59606.7 60298.7 60331.7 60763.4 10223.6 10253.7 10302.1 10313.4 10332.5 18079.9 18166.5 18263.8 18282.7 18289.2 6577.3 6685.1 6739.0 6764.5 6771.6 3664.6 3699.4 3706.7 3733.3 3768.1 2732.5 2824.0 2827.8 2834.7 2842.8 512.8 514.3 523.2 525.4 531.7 483.4 506.6 573.4 574.6 576.3 7666.9 7943.4 9010.1 9038.1 9171.5 513.0 596.9 609.3 622.1 629.5 3879.9 3973.2 3986.3 4067.4 4100.2 62867.0 95465.0 95652.5 96409.5 98578.0 25414.7 25564.0 43793.0 79256.2 81158.0 65893.7 73676.0 74193.6 76093.6 76842.0 7557.9 7565.0 7594.0 7811.2 7837.9 41789.0 42212.2 42297.5 42355.0 42840.4 59812.7 63893.7 64008.7 64664.0 64837.4 9973.5 10059.2 10285.4 10451.9 10635.8 11239.9 11656.7 11806.8 12575.7 12875.4 11189.8 11658.8 11995.3 12126.7 12204.9 12496.9 12507.3 12514.3 12887.0 12942.8 11071.7 11319.4 11348.1 11384.7 11558.4 10573.9 10588.2 10749.0 10760.4 10786.2 9738.7 9855.4 9900.5 10059.7 10155.4 07:49:30 INFO - PROCESS | 15690 | -------- Summary: end -------- 07:49:30 INFO - PROCESS | 15690 | 07:49:31 INFO - TEST-INFO | 15690: exit 0 07:49:31 INFO - TEST-OK | dromaeo_css | took 1116808ms 07:49:31 INFO - TEST-START | kraken 07:49:31 INFO - operating with platform_type : linux_ 07:49:31 INFO - Initialising browser for kraken test... 07:49:31 INFO - TEST-INFO | started process 15938 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFVau4D/profile http://localhost:37251/getInfo.html) 07:49:36 INFO - PROCESS | 15938 | __metrics Screen width/height:1600/1200 07:49:36 INFO - PROCESS | 15938 | colorDepth:24 07:49:36 INFO - PROCESS | 15938 | Browser inner width/height: 1024/697 07:49:36 INFO - PROCESS | 15938 | __metrics 07:49:37 ERROR - PROCESS | 15938 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 07:49:38 INFO - TEST-INFO | 15938: exit 0 07:49:38 INFO - Browser initialized. 07:49:38 INFO - Running cycle 1/1 for kraken test... 07:49:38 INFO - TEST-INFO | started process 16060 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFVau4D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:49:50 INFO - PROCESS | 16060 | RSS: Main: 169480192 07:49:50 INFO - PROCESS | 16060 | 07:49:52 INFO - PROCESS | 16060 | Cycle 1(1): loaded http://localhost:37251/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37251/tests/kraken/driver.html?testName=audio-beat-detection) 07:49:53 INFO - PROCESS | 16060 | RSS: Main: 174014464 07:49:53 INFO - PROCESS | 16060 | 07:49:56 INFO - PROCESS | 16060 | Cycle 1(1): loaded http://localhost:37251/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37251/tests/kraken/driver.html?testName=audio-dft) 07:49:57 INFO - PROCESS | 16060 | RSS: Main: 173477888 07:49:57 INFO - PROCESS | 16060 | 07:50:00 INFO - PROCESS | 16060 | Cycle 1(1): loaded http://localhost:37251/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37251/tests/kraken/driver.html?testName=audio-fft) 07:50:00 INFO - PROCESS | 16060 | RSS: Main: 169005056 07:50:00 INFO - PROCESS | 16060 | 07:50:02 INFO - PROCESS | 16060 | Cycle 1(1): loaded http://localhost:37251/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37251/tests/kraken/driver.html?testName=audio-oscillator) 07:50:03 INFO - PROCESS | 16060 | RSS: Main: 169508864 07:50:03 INFO - PROCESS | 16060 | 07:50:05 INFO - PROCESS | 16060 | Cycle 1(1): loaded http://localhost:37251/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37251/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:50:06 INFO - PROCESS | 16060 | RSS: Main: 169209856 07:50:06 INFO - PROCESS | 16060 | 07:50:09 INFO - PROCESS | 16060 | Cycle 1(1): loaded http://localhost:37251/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37251/tests/kraken/driver.html?testName=imaging-darkroom) 07:50:10 INFO - PROCESS | 16060 | RSS: Main: 169791488 07:50:10 INFO - PROCESS | 16060 | 07:50:13 INFO - PROCESS | 16060 | Cycle 1(1): loaded http://localhost:37251/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37251/tests/kraken/driver.html?testName=imaging-desaturate) 07:50:14 INFO - PROCESS | 16060 | RSS: Main: 167108608 07:50:14 INFO - PROCESS | 16060 | 07:50:17 INFO - PROCESS | 16060 | Cycle 1(1): loaded http://localhost:37251/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37251/tests/kraken/driver.html?testName=json-parse-financial) 07:50:17 INFO - PROCESS | 16060 | RSS: Main: 169013248 07:50:17 INFO - PROCESS | 16060 | 07:50:19 INFO - PROCESS | 16060 | Cycle 1(1): loaded http://localhost:37251/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37251/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:50:20 INFO - PROCESS | 16060 | RSS: Main: 168210432 07:50:20 INFO - PROCESS | 16060 | 07:50:22 INFO - PROCESS | 16060 | Cycle 1(1): loaded http://localhost:37251/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37251/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:50:22 INFO - PROCESS | 16060 | RSS: Main: 168697856 07:50:22 INFO - PROCESS | 16060 | 07:50:25 INFO - PROCESS | 16060 | Cycle 1(1): loaded http://localhost:37251/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37251/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:50:25 INFO - PROCESS | 16060 | RSS: Main: 169058304 07:50:25 INFO - PROCESS | 16060 | 07:50:28 INFO - PROCESS | 16060 | Cycle 1(1): loaded http://localhost:37251/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:50:29 INFO - PROCESS | 16060 | RSS: Main: 170172416 07:50:29 INFO - PROCESS | 16060 | 07:50:32 INFO - PROCESS | 16060 | Cycle 1(1): loaded http://localhost:37251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:50:32 INFO - PROCESS | 16060 | RSS: Main: 168943616 07:50:32 INFO - PROCESS | 16060 | 07:50:34 INFO - PROCESS | 16060 | Cycle 1(1): loaded http://localhost:37251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37251/tests/kraken/driver.html?testName=ai-astar) 07:50:34 INFO - PROCESS | 16060 | RSS: Main: 170463232 07:50:34 INFO - PROCESS | 16060 | 07:50:34 INFO - PROCESS | 16060 | __start_tp_report 07:50:34 INFO - PROCESS | 16060 | _x_x_mozilla_page_load 07:50:34 INFO - PROCESS | 16060 | _x_x_mozilla_page_load_details 07:50:34 INFO - PROCESS | 16060 | |i|pagename|runs| 07:50:34 INFO - PROCESS | 16060 | |0;ai-astar;104;114;109;116;115;116;116;115;114;113 07:50:34 INFO - PROCESS | 16060 | |1;audio-beat-detection;149;132;145;175;124;159;149;125;184;127 07:50:34 INFO - PROCESS | 16060 | |2;audio-dft;162;165;168;166;174;165;164;164;162;163 07:50:34 INFO - PROCESS | 16060 | |3;audio-fft;76;86;75;161;77;78;75;76;160;78 07:50:34 INFO - PROCESS | 16060 | |4;audio-oscillator;85;86;142;87;89;87;135;86;87;140 07:50:34 INFO - PROCESS | 16060 | |5;imaging-gaussian-blur;117;117;118;118;118;118;118;117;119;118 07:50:34 INFO - PROCESS | 16060 | |6;imaging-darkroom;148;148;148;148;148;148;147;147;149;147 07:50:34 INFO - PROCESS | 16060 | |7;imaging-desaturate;96;95;104;95;95;95;96;95;95;95 07:50:34 INFO - PROCESS | 16060 | |8;json-parse-financial;65;65;65;66;74;65;64;65;65;67 07:50:34 INFO - PROCESS | 16060 | |9;json-stringify-tinderbox;65;66;66;65;65;68;65;66;65;65 07:50:34 INFO - PROCESS | 16060 | |10;stanford-crypto-aes;79;80;79;79;88;83;85;80;84;80 07:50:34 INFO - PROCESS | 16060 | |11;stanford-crypto-ccm;137;136;144;134;136;134;134;136;171;132 07:50:34 INFO - PROCESS | 16060 | |12;stanford-crypto-pbkdf2;169;165;172;168;175;166;172;172;168;169 07:50:34 INFO - PROCESS | 16060 | |13;stanford-crypto-sha256-iterative;71;72;72;68;68;69;67;68;66;69 07:50:34 INFO - PROCESS | 16060 | __end_tp_report 07:50:34 INFO - PROCESS | 16060 | __start_cc_report 07:50:34 INFO - PROCESS | 16060 | _x_x_mozilla_cycle_collect,1010 07:50:34 INFO - PROCESS | 16060 | __end_cc_report 07:50:34 INFO - PROCESS | 16060 | __startTimestamp1467903034746__endTimestamp 07:50:34 INFO - PROCESS | 16060 | 07:50:34 INFO - PROCESS | 16060 | ------- Summary: start ------- 07:50:34 INFO - PROCESS | 16060 | Number of tests: 14 07:50:34 INFO - PROCESS | 16060 | 07:50:34 INFO - PROCESS | 16060 | [#0] ai-astar Cycles:10 Average:113.20 Median:115.00 stddev:3.85 (3.4%) stddev-sans-first:2.22 07:50:34 INFO - PROCESS | 16060 | Values: 104.0 114.0 109.0 116.0 115.0 116.0 116.0 115.0 114.0 113.0 07:50:34 INFO - PROCESS | 16060 | 07:50:34 INFO - PROCESS | 16060 | [#1] audio-beat-detection Cycles:10 Average:146.90 Median:149.00 stddev:20.94 (14.1%) stddev-sans-first:22.20 07:50:34 INFO - PROCESS | 16060 | Values: 149.0 132.0 145.0 175.0 124.0 159.0 149.0 125.0 184.0 127.0 07:50:34 INFO - PROCESS | 16060 | 07:50:34 INFO - PROCESS | 16060 | [#2] audio-dft Cycles:10 Average:165.30 Median:165.00 stddev:3.56 (2.2%) stddev-sans-first:3.57 07:50:34 INFO - PROCESS | 16060 | Values: 162.0 165.0 168.0 166.0 174.0 165.0 164.0 164.0 162.0 163.0 07:50:34 INFO - PROCESS | 16060 | 07:50:34 INFO - PROCESS | 16060 | [#3] audio-fft Cycles:10 Average:94.20 Median:76.50 stddev:35.09 (45.9%) stddev-sans-first:36.59 07:50:34 INFO - PROCESS | 16060 | Values: 76.0 86.0 75.0 161.0 77.0 78.0 75.0 76.0 160.0 78.0 07:50:34 INFO - PROCESS | 16060 | 07:50:34 INFO - PROCESS | 16060 | [#4] audio-oscillator Cycles:10 Average:102.40 Median:86.50 stddev:25.33 (29.3%) stddev-sans-first:26.08 07:50:34 INFO - PROCESS | 16060 | Values: 85.0 86.0 142.0 87.0 89.0 87.0 135.0 86.0 87.0 140.0 07:50:34 INFO - PROCESS | 16060 | 07:50:34 INFO - PROCESS | 16060 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 07:50:34 INFO - PROCESS | 16060 | Values: 117.0 117.0 118.0 118.0 118.0 118.0 118.0 117.0 119.0 118.0 07:50:34 INFO - PROCESS | 16060 | 07:50:34 INFO - PROCESS | 16060 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 07:50:34 INFO - PROCESS | 16060 | Values: 148.0 148.0 148.0 148.0 148.0 148.0 147.0 147.0 149.0 147.0 07:50:34 INFO - PROCESS | 16060 | 07:50:34 INFO - PROCESS | 16060 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:95.00 stddev:2.81 (3.0%) stddev-sans-first:2.98 07:50:34 INFO - PROCESS | 16060 | Values: 96.0 95.0 104.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 07:50:34 INFO - PROCESS | 16060 | 07:50:34 INFO - PROCESS | 16060 | [#8] json-parse-financial Cycles:10 Average:66.10 Median:65.00 stddev:2.88 (4.4%) stddev-sans-first:3.03 07:50:34 INFO - PROCESS | 16060 | Values: 65.0 65.0 65.0 66.0 74.0 65.0 64.0 65.0 65.0 67.0 07:50:34 INFO - PROCESS | 16060 | 07:50:34 INFO - PROCESS | 16060 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:65.50 stddev:0.97 (1.5%) stddev-sans-first:1.00 07:50:34 INFO - PROCESS | 16060 | Values: 65.0 66.0 66.0 65.0 65.0 68.0 65.0 66.0 65.0 65.0 07:50:34 INFO - PROCESS | 16060 | 07:50:34 INFO - PROCESS | 16060 | [#10] stanford-crypto-aes Cycles:10 Average:81.70 Median:81.50 stddev:3.13 (3.8%) stddev-sans-first:3.16 07:50:34 INFO - PROCESS | 16060 | Values: 79.0 80.0 79.0 79.0 88.0 83.0 85.0 80.0 84.0 80.0 07:50:34 INFO - PROCESS | 16060 | 07:50:34 INFO - PROCESS | 16060 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:136.00 stddev:11.56 (8.5%) stddev-sans-first:12.23 07:50:34 INFO - PROCESS | 16060 | Values: 137.0 136.0 144.0 134.0 136.0 134.0 134.0 136.0 171.0 132.0 07:50:34 INFO - PROCESS | 16060 | 07:50:34 INFO - PROCESS | 16060 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.60 Median:170.50 stddev:3.10 (1.8%) stddev-sans-first:3.28 07:50:34 INFO - PROCESS | 16060 | Values: 169.0 165.0 172.0 168.0 175.0 166.0 172.0 172.0 168.0 169.0 07:50:34 INFO - PROCESS | 16060 | 07:50:34 INFO - PROCESS | 16060 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:2.05 (3.0%) stddev-sans-first:2.05 07:50:34 INFO - PROCESS | 16060 | Values: 71.0 72.0 72.0 68.0 68.0 69.0 67.0 68.0 66.0 69.0 07:50:34 INFO - PROCESS | 16060 | -------- Summary: end -------- 07:50:34 INFO - PROCESS | 16060 | 07:50:35 INFO - TEST-INFO | 16060: exit 0 07:50:35 INFO - TEST-OK | kraken | took 64271ms 07:50:35 INFO - SUITE-END | took 1181s 07:50:35 INFO - Completed test suite (00:19:41) 07:50:35 INFO - javascript benchmark 07:50:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6366.733575311126, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2587.3531617095728, 2615.6991945926225, 2630.3687115092384, 2646.0738741440487, 2652.018753061366, 4734.739589322586, 4774.952250477494, 4791.760411979404, 4816.542428469299, 4845.58812500937, 4646.210144275473, 4741.288806679, 4745.193317136086, 4750.382450281467, 4764.952350476494, 4326.264535029045, 4421.358902959069, 4423.800928958189, 4455.977720111395, 4471.105778844228, 4461.866144015668, 4522.547745225484, 4530.161920044786, 4535.523770004152, 4563.885902852422, 4276.358546218076, 4359.760213188273, 4364.41080454141, 4381.101874115799, 4385.2106620808245, 4339.240632889232, 4424.40270563473, 4426.070525189714, 4433.9556604433865, 4438.112377524476, 4366.039471316337, 4402.955970440286, 4421.358902959053, 4421.425214722098, 4453.421055262827, 4741.122892264908, 4815.66290359675, 4829.468758436569, 4836.395450568679, 4864.2217245240945, 5139.408967968657, 5141.048905952411, 5146.7683954221775, 5168.8966220675375, 5191.117510023305, 5056.974715126401, 5115.897682046376, 5121.539061484447, 5125.589952803767, 5150.690958542499, 4762.761681962715, 4775.379200703921, 4783.282507623884, 4784.66507344486, 4788.377510923628, 5229.189475631283, 5241.42344342122, 5243.68537887728, 5251.793204437746, 5266.657667251617, 4972.602191824718, 4986.626003049786, 4997.825076122391, 5040.722760248222, 5050.393952725696, 4995.275685025651, 5043.394792624835, 5096.898062038738, 5118.10433174193, 5186.066508028591, 4960.553550180501, 5059.747012649353, 5064.974675126601, 5077.136886729265, 5086.872828179326, 5005.699658020458, 5010.974945125251, 5057.190849464068, 5078.390593128848, 5083.313752643419, 4267.786610669516, 4281.186574550826, 4292.163028209532, 4320.697551171388, 4325.307950727868, 3683.226522430266, 3683.834227459771, 3723.553173619183, 3745.1198968242443, 3798.7910664913693, 4413.7351758894565, 4445.466544014739, 4464.665150113755, 4474.530174331713, 4489.483709373464, 5116.0, 5123.129068058439, 5159.974200129051, 5167.870803229875, 5172.224166374998, 4341.60925516705, 4377.802998865059, 4416.271315233015, 4456.7548784817145, 4504.887377815516, 4551.180787458223, 4576.061907308994, 4577.153226653079, 4616.884577885579, 4630.6758526902795, 4786.329913812069, 4794.849236183221, 4795.184818580849, 4796.688215265996, 4853.733044682576, 4988.900221995613, 5119.692818430906, 5127.333446651912, 5158.948410515847, 5185.248139019896, 4816.8073277069925, 4838.443578988461, 4855.872408865163, 4858.611311095033, 4902.730349830794, 5090.872728181825, 5104.69371837691, 5110.9488905110475, 5111.182210846247, 5144.485551444825, 4963.131451995959, 5037.471065538066, 5104.2343648453025, 5124.410692770379, 5174.990876778992, 4954.677945933503, 4954.900901982012, 4954.900901982012, 5006.49935006511, 5013.273075403973, 5032.194848824171, 5032.924506132485, 5035.672681275705, 5059.822906198266, 5079.619028572798, 4713.835015774432, 4843.104025755247, 4866.537678920497, 4959.851204463872, 4974.204127339608, 5019.0965626187635, 5043.621728370314, 5043.798248070183, 5045.217991211368, 5081.263216833612, 4943.233798761198, 4945.505449455026, 4949.084419382426, 4951.207806750903, 4978.676386035041], "value": 4696.720387046172, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [530.8646295194725, 534.8288547664744, 563.2255648483335, 576.6482445708118, 578.4186892173365, 39980.0, 41478.17043659125, 41517.0, 41522.37716434252, 45142.0, 41262.0, 41341.586584134224, 41758.37362439566, 41821.0, 41827.372589411105, 7753.844923101535, 7864.449488535804, 7867.881981770278, 7885.250901164409, 7888.408369372291, 7726.806829829243, 7847.332976696959, 7848.4113691473085, 7883.0, 7885.0, 7834.529928204298, 7841.059072911258, 7924.405669574776, 7964.283214510722, 7971.641276142587, 7781.805454863617, 7868.409869259771, 7869.685212591489, 7874.212578742137, 7878.4485086044, 7748.7675369739, 7762.0, 7831.256030677134, 7834.4907581007055, 7863.410244231705, 38932.0, 39393.40909886354, 39483.60516394857, 39705.60294397048, 39783.0, 3044.284593120637, 3182.45898197307, 3217.6460589335156, 3288.7862288951383, 3579.4451859961487, 29357.0, 29531.70468295311, 29645.329800794865, 29832.0, 30214.69785302163, 3019.048999565152, 3027.9394412111633, 3048.6189226346705, 3057.877684892602, 3101.7518598512065, 251675.0, 252355.0, 252651.0, 253138.0, 253676.0, 31891.840540797613, 33125.17187070342, 50901.49098508967, 51393.229101563506, 51739.0, 34038.319233615686, 34229.828850855585, 34344.14139646529, 34464.82767586146, 34478.82760586181, 13806.17162970225, 13956.720865582834, 13958.441662333596, 13961.232132232824, 13994.090384125, 11376.488058037243, 11398.031167350702, 11467.483963221675, 11491.77016459666, 11498.080153587693, 7938.975561231849, 7993.960030199812, 8007.639656215484, 8011.359091272684, 8097.797555061053, 3124.4063627910623, 3136.8431578420987, 3150.763692723055, 3154.495280755068, 3200.9839950800097, 908.8727578138934, 914.2548822709471, 942.8444306689456, 945.935822200025, 1058.4496062047692, 28545.28636784097, 28604.570931436047, 28634.713652863622, 28998.0, 29306.413871722445, 891.3136884598823, 993.3940296419179, 1012.6202673997251, 1026.7484466305652, 1061.3154515337565, 15200.467983620742, 15316.621504064688, 15471.845281547041, 15493.380264789508, 15679.294431750599, 361293.0, 365160.0, 366220.0, 366491.0, 368434.5252379803, 48696.0, 48936.0, 48948.26577601339, 49148.508514915105, 49299.50700493021, 1152.2683096233952, 1188.037689471531, 1197.287613869746, 1211.273236058358, 1214.878512148778, 26998.595021074307, 28192.0, 28276.953766604674, 28353.858230708713, 28403.857980709963, 42046.0, 42661.0, 42792.0, 42985.355219672354, 43025.0, 314633.0, 315846.0, 316762.0, 317734.0, 317815.0, 24859.254222373358, 24985.125520606693, 25262.621060683738, 25445.87277063603, 25535.0, 42259.0, 42402.575974239866, 42810.78594607007, 43256.13487730165, 43358.13283734245, 37029.587205961, 37489.4376584346, 37622.43566346452, 37624.43563346497, 38167.42748858825, 36701.44947825732, 37454.62545374512, 37600.0, 37691.81154094212, 37943.81028094842, 31351.529727054567, 35434.645653543135, 36149.27701446009, 36732.081697956695, 36882.26235475329, 32328.0, 33432.83283583567, 33446.33107337791, 33520.83239583787, 34064.65935340714, 25363.6195457072, 25630.487390251717, 25821.225363239133, 26039.218823435327, 26052.609210861472], "value": 16591.32044905298, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.0312928562523, 369.4882587616151, 372.8657683234036, 380.1143336027057, 385.4565063260803, 16315.184240787958, 16966.0, 17808.910955445237, 17858.107094645264, 18007.279708811664, 10661.200409969244, 15952.361905523794, 16825.91587042063, 16841.0, 17482.38811641593, 4608.377868987685, 4691.085238378518, 4786.162421576228, 4794.0, 4803.495632958541, 3472.2361080562237, 5213.6089793265655, 5490.505854473096, 5498.670079795225, 5565.0, 5467.45325467454, 5518.448155184489, 5519.282493275889, 5526.281583394173, 5547.417521160281, 5958.136070269787, 6106.755729770804, 6130.724117414727, 6131.202943617323, 6146.0473626587955, 4533.546645335473, 4844.442889067767, 5393.811216607439, 5406.107992181285, 5428.37573679028, 12158.5744498943, 12347.691307717289, 12390.504379824797, 12518.248905065726, 12612.243265404106, 1816.8455681267108, 1863.9813601863943, 1972.3589833304234, 2134.8398870084807, 2418.6855708757926, 9303.953480232556, 9411.388259763093, 9554.665586704501, 11023.393713345762, 13528.188308701509, 1732.6967780638338, 1866.3840932492244, 1973.062795172296, 1985.2753744883014, 2017.4149496645955, 71023.64488177525, 71070.0, 71339.28660713378, 72083.27916720818, 74430.62784686097, 9903.702888913343, 10003.24975626831, 10110.949445252874, 10115.7471063224, 10203.897961020442, 13174.341282935815, 13318.067735258439, 13352.332383380792, 13428.597142085753, 13436.261005644783, 7705.499142555716, 7734.2265773422205, 7751.92248077512, 7840.882386764203, 7906.723264685708, 7642.847143057108, 7735.265149810759, 7800.336971357385, 7825.060992680801, 7864.0, 4198.391233271159, 4318.632916202158, 4321.632661223768, 4438.689291749546, 4461.5092339842595, 1612.4275882061934, 1670.158635139175, 1771.9822801772075, 1806.7109262517934, 1855.4897403214225, 716.2872941423317, 825.2119226139023, 859.3426029087752, 879.6041781198486, 901.0493928904937, 15840.524784256491, 17104.315827366765, 17170.570735731708, 17718.379856704953, 17769.28922843098, 836.6946064686467, 870.6169285514353, 872.289084396215, 885.8449771289999, 890.8218356328631, 8318.960129983752, 9620.567074481665, 9687.370320929118, 9732.610695572239, 9756.560954757053, 371631.0, 372281.0, 372531.0, 381348.0, 390633.0, 86805.56597216973, 90985.0, 92412.0, 92464.0, 94048.0, 842.6924172676929, 881.1937077573948, 890.4479222881855, 949.4540639132526, 950.1686024728501, 13233.404496797475, 15671.294791734172, 16282.918585406996, 16413.67172656564, 16539.0, 38897.80551097226, 39053.0, 39070.80464597659, 39231.6076839228, 39340.803295983336, 49414.75292623514, 53267.46732532625, 53282.20076698775, 53590.464095360105, 53736.462635373144, 7509.624518774149, 7562.584057876869, 7743.032120984877, 7781.9610901945125, 7819.960900195462, 10732.946335268585, 11257.039390659162, 11394.430278485877, 11588.478518466858, 11696.122790790554, 10256.487175641338, 10389.480525973822, 10555.0, 10557.788844223227, 10702.304350217211, 10017.599296028076, 10022.398656080659, 10184.490775461345, 10198.796024079626, 10280.948595256976, 9458.196053335543, 10167.491625418552, 10182.0, 10194.0, 10278.17774578017, 7561.0, 7585.355244804033, 7645.579493127709, 7660.2722741339485, 7660.961695191489, 9274.907250927405, 9324.207442367204, 9969.0, 10181.592736290762, 10209.38743675382], "value": 8198.328227695265, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1390.993045034775, 1444.8771854392378, 1494.6114010357303, 1717.0985232752803, 1725.2236493577877, 6880.621565813878, 7343.522671026386, 7547.5471471711735, 7856.8428631427405, 7864.252895974881, 7628.694852205919, 7783.221677832214, 7913.406494512906, 7919.604019799016, 7920.564368959705, 2208.02846747431, 2231.040652519416, 2232.2521955145044, 2245.86524808512, 2246.0903334149693, 2180.8800515971616, 2202.5044365017825, 2237.552489502098, 2255.4812393149587, 2258.2434884313775, 2206.249875042485, 2223.144089525528, 2231.6540936154843, 2233.765454627265, 2258.2096266306744, 2153.6661817418326, 2173.217641649005, 2180.8473406861526, 2184.868907865533, 2189.824814014875, 2165.317924853666, 2177.520945392011, 2178.2593918067773, 2179.2808373236794, 2186.650135978236, 7942.602869856484, 7953.562554059525, 8018.0779210390965, 8021.157778433298, 8048.758537243892, 4637.304404339376, 4746.762661866893, 4762.38089048425, 4766.618670506351, 4767.976160119212, 2810.7076450854397, 2890.2918784897624, 2911.5195992661183, 2913.8397388143644, 2939.6619388770137, 890.7416849113749, 907.120093509295, 912.3157631776168, 917.8439665256856, 932.3799673217302, 10665.52005159762, 10698.732531686692, 10738.892611073867, 10748.570057197703, 10784.622538211124, 4092.1611069730634, 4193.51774545925, 4293.368519962394, 4299.419578356944, 4343.19650864591, 9158.95420522893, 9191.172794448532, 9231.0, 9241.768955776159, 9261.49061801594, 4701.694389864648, 4745.430548334153, 4750.144973904661, 4756.571908528249, 4765.4996225395835, 3517.7889326640484, 4184.874453766331, 4300.333448315516, 4306.698531102856, 4338.154059958278, 3665.157013886821, 3726.4410338449447, 3731.533558305212, 3774.9056273592832, 3831.923361532754, 1217.5981925964588, 1243.3348158735034, 1245.2590708528412, 1245.7633049720705, 1252.6680429686141, 652.9183852018498, 733.7872017114977, 813.6785969541997, 817.5896578402209, 834.5368320582014, 5229.635596127791, 5266.236395722599, 5341.706206158621, 5454.481824226692, 5477.972610137003, 409.9403043133474, 411.5822440223176, 413.7827640488707, 435.8561674647359, 437.84675363623114, 3510.490489089665, 3513.0690367052753, 3528.8588456461966, 3576.8926932192076, 3591.6408359164398, 9111.498867562215, 9421.38760980534, 9422.670206542738, 9427.198688111588, 9431.245500359955, 9279.211267042241, 9355.251579873593, 9370.39092458988, 9370.85943710845, 9375.671851485165, 7083.583283343352, 7171.713131474787, 7174.892376614355, 7190.209077001526, 7195.784126476214, 4934.5805606523845, 5062.898742025065, 5070.923936141035, 5109.182530795055, 5214.97392513035, 8771.429857059271, 8773.780655483664, 8806.515641639771, 8838.64645414202, 8889.911100888909, 8801.779955501164, 8920.509371984603, 8924.0, 8955.149260820212, 8960.327975402, 5786.33457152416, 6518.511111666549, 6754.324567543206, 6773.559718618274, 6820.045193672989, 7568.508046976929, 7572.583507907118, 7636.274553917369, 7637.465377423527, 7641.656125474478, 6628.668566571749, 6737.66311684404, 6773.356531129535, 6944.791656250321, 7085.0, 6920.5847649141215, 6928.792136235921, 6936.618485983117, 6978.755743548952, 7010.579365238102, 5669.149627555899, 5695.0, 5727.284089488814, 5746.540276777764, 5791.0734282514595, 4288.592583704543, 4306.4832220133785, 4393.62654174386, 4398.956010439854, 4420.425344705168, 4423.071155057474, 4486.887827804331, 4495.505494395548, 4546.704464209815, 4558.222293305547], "value": 4052.4020736814277, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.9623797025372, 301.74502545349173, 303.0242618767569, 305.5111821086261, 306.78371747917714, 4998.475160108186, 5069.0, 5166.612504062192, 5168.095583272931, 5179.187284450445, 5035.295058691786, 5045.091883460976, 5058.266551350052, 5073.264376665381, 5126.461721519243, 3712.6658600725927, 3817.3701339279123, 3922.901587555489, 3960.7425517341353, 3978.38335058065, 3908.7654740715507, 3910.432987216852, 3912.4131380293043, 3918.6277303656107, 3940.8226629801584, 3911.0, 3912.7697212588837, 3919.0, 3929.646331830135, 3947.50656167979, 3853.903652408684, 3929.4302326162688, 3940.192260586573, 3946.48695669564, 3957.8021098944937, 3408.9829550852087, 3410.454327307644, 3416.282580658065, 3417.9658203418144, 3436.467347561132, 4965.801367945278, 4972.676776009584, 4981.950180498185, 4988.87527811804, 5013.824516141917, 4450.287953927356, 4457.977710111461, 4476.574725401082, 4482.0, 4500.0874628282845, 5110.616703747234, 5295.511109778437, 5301.8866038131655, 5312.335958005249, 5337.2527846101575, 3740.6446387593137, 3759.830807613664, 3761.811909404546, 3763.1909139535132, 3763.8870833875026, 5600.487868275583, 5620.325560932673, 5639.210510528529, 5661.660300381949, 5671.914921276184, 3682.59491455945, 3740.738148329591, 3752.981235093807, 3772.773633581994, 3791.75353602015, 3796.6013568575454, 3804.6956243500454, 3818.3890577507464, 3820.9235815283537, 3821.541415030214, 4405.691601587858, 4407.515173330931, 4421.270490369053, 4424.469063712375, 4442.378067070613, 5238.60710446718, 5322.121849894724, 5327.174287985368, 5349.973250133802, 5359.410464848864, 1328.362386054699, 1329.940152693131, 1346.299924039494, 1357.3281225793098, 1357.4909408971635, 817.0032560276453, 836.9121242269474, 837.6188834080479, 856.2764464027887, 857.4683696108452, 4125.339945608688, 4448.822047118144, 4561.68068235227, 4693.319468677091, 4709.246520556763, 5447.291852059207, 5479.561635069185, 5503.532199763065, 5504.2294078829, 5508.7521061552325, 4630.884227894262, 4672.649551283667, 4685.250359942393, 4685.320628508915, 4690.296455531629, 2761.9447611047667, 2880.4095160492047, 2899.869505872241, 2913.7814663900294, 2932.310906936868, 5085.364329458817, 5102.3877134743325, 5141.9432227109455, 5149.536541711264, 5169.922451163236, 5489.2589500417735, 5554.389017208185, 5599.972000139973, 5643.746031428595, 5662.66024038559, 5098.515641014098, 5109.923351149736, 5126.1798112302595, 5170.638055336166, 5170.8965820684125, 5492.534927746918, 5510.862228444321, 5517.255170552085, 5526.281583394133, 5546.168074788814, 5192.273081768631, 5385.75764090609, 5402.027635025733, 5405.432429594836, 5412.215228791724, 5135.409427915837, 5147.246223270532, 5157.0, 5165.431802501797, 5165.586753059822, 3802.391617341212, 3814.4278358245374, 3824.94262586067, 3834.2523207974177, 3840.6543411093135, 5226.503482169188, 5325.334333208349, 5455.208994695826, 5516.282883225315, 5526.8393637335, 5192.896142077062, 5201.843944681666, 5230.503102205284, 5245.947540524546, 5268.315119034501, 5276.498732620395, 5286.312779338815, 5291.708956007456, 5299.49654782795, 5300.549453296513, 5054.873628159326, 5265.2891859599995, 5274.815381461631, 5281.287026251561, 5284.233786101071, 5123.540700463873, 5166.922496162485, 5278.208268759717, 5391.568674506108, 5399.325084364455, 5236.869078273074, 5239.711815850165, 5262.131943160123, 5265.763040663102, 5269.947300527099], "value": 3973.0517707130693, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [612.2255346986063, 659.5712786688651, 667.4326822201128, 683.4976292425064, 751.9360854327382, 12798.540386139637, 12824.935875320622, 13294.0, 13301.06892517523, 13622.318884055807, 12555.435005424755, 12565.623031309053, 12627.36863156843, 12645.304508252066, 12669.23984560927, 620.1875543038634, 775.6974779835855, 803.1366281247653, 803.6504120707482, 804.0753133896008, 770.7263921307939, 789.9802504937365, 790.4387884601939, 790.5572879187673, 791.0507391130666, 833.62903507939, 833.8540755367817, 834.7120243515977, 838.1995194589152, 838.2832678060262, 825.6573521988398, 826.7395770332356, 827.2472050434106, 830.6179157587517, 834.0575150080431, 604.8276241271261, 608.6500262349123, 609.3114780298279, 609.7012463892705, 613.772904025509, 13167.736645267041, 13186.538471153559, 13192.538261160813, 13196.14225075367, 13261.46954121834, 13519.729605407836, 13962.58112256634, 13989.160650361011, 14009.71980560383, 14212.928935355361, 10009.0, 10140.797184056277, 10214.233932455096, 10712.517936692868, 10822.0, 4108.958910410887, 4130.0, 4131.566185550504, 4167.499900012018, 4237.6821738369745, 59451.405485945455, 59606.70196648989, 60298.69850650762, 60331.69834150845, 60763.392366076216, 10223.642172523925, 10253.692389228336, 10302.072813446675, 10313.432761198055, 10332.483375831329, 18079.909600451912, 18166.545836353933, 18263.817361826477, 18282.725759113622, 18289.176987035615, 6577.3422657733845, 6685.0640910272605, 6739.0, 6764.4926630502905, 6771.559848609824, 3664.578573464086, 3699.3896007159055, 3706.666400023957, 3733.309337772521, 3768.1144930941205, 2732.53546897028, 2823.9858800705865, 2827.7596404305455, 2834.6598408190735, 2842.7725781937397, 512.7846304552022, 514.2800079888111, 523.1995047577213, 525.4430303877901, 531.665051017864, 483.3981692792496, 506.60231718101113, 573.4494884910449, 574.635106707244, 576.3026737647493, 7666.8849967250535, 7943.364530837634, 9010.144036316671, 9038.141376569216, 9171.541422928827, 513.0406140517257, 596.8567543789459, 609.3297372889785, 622.1445512420422, 629.5089829932659, 3879.8642047528765, 3973.245083434196, 3986.262541429845, 4067.3695577185586, 4100.1691913445175, 62867.0, 95465.0, 95652.52173739087, 96409.51795241119, 98578.0, 25414.745852541608, 25564.0, 43793.0, 79256.20743792603, 81158.0, 65893.67053164703, 73676.0, 74193.62903185449, 76093.6195319031, 76842.0, 7557.886631700639, 7565.0, 7593.957368300885, 7811.179826118403, 7837.921620783947, 41789.0, 42212.1557568853, 42297.462152270964, 42355.0, 42840.35739463973, 59812.700936495035, 63893.68053159704, 64008.67995660178, 64664.0, 64837.351626483134, 9973.451460169761, 10059.159830971912, 10285.382877027403, 10451.895481045092, 10635.840462393226, 11239.943800280946, 11656.650300491, 11806.763864722485, 12575.748485030432, 12875.420606072936, 11189.832152517556, 11658.76682466329, 11995.340256285988, 12126.696832579257, 12204.938975305422, 12496.87503124957, 12507.333565355813, 12514.31171285588, 12887.033472489413, 12942.80585791195, 11071.699015583445, 11319.377434241196, 11348.092152627934, 11384.715382115513, 11558.364289964133, 10573.9471302643, 10588.205884558844, 10749.032587067202, 10760.3543787373, 10786.191035672513, 9738.659146929824, 9855.35940163887, 9900.455474948947, 10059.736559274397, 10155.39067655943], "value": 6474.652536642139, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 109.0, 116.0, 115.0, 116.0, 116.0, 115.0, 114.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 132.0, 145.0, 175.0, 124.0, 159.0, 149.0, 125.0, 184.0, 127.0], "value": 146.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 168.0, 166.0, 174.0, 165.0, 164.0, 164.0, 162.0, 163.0], "value": 165.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 86.0, 75.0, 161.0, 77.0, 78.0, 75.0, 76.0, 160.0, 78.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 142.0, 87.0, 89.0, 87.0, 135.0, 86.0, 87.0, 140.0], "value": 102.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 119.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 148.0, 148.0, 147.0, 147.0, 149.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 104.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 66.0, 74.0, 65.0, 64.0, 65.0, 65.0, 67.0], "value": 66.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 65.0, 65.0, 68.0, 65.0, 66.0, 65.0, 65.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 79.0, 79.0, 88.0, 83.0, 85.0, 80.0, 84.0, 80.0], "value": 81.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 144.0, 134.0, 136.0, 134.0, 134.0, 136.0, 171.0, 132.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 165.0, 172.0, 168.0, 175.0, 166.0, 172.0, 172.0, 168.0, 169.0], "value": 169.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 72.0, 68.0, 68.0, 69.0, 67.0, 68.0, 66.0, 69.0], "value": 69.0, "unit": "score"}]}]} 07:50:35 INFO - Return code: 0 07:50:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:50:36 ERROR - # TBPL SUCCESS # 07:50:36 INFO - Running post-action listener: _resource_record_post_action 07:50:36 INFO - ##### 07:50:36 INFO - ##### Finished run-tests step (success) 07:50:36 INFO - ##### 07:50:36 INFO - Running post-run listener: _resource_record_post_run 07:50:36 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553611264; Read time: 16; Write time: 453756 07:50:36 INFO - TinderboxPrint: CPU usage
13.3% 07:50:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 07:50:36 INFO - TinderboxPrint: I/O write bytes / time
553,611,264 / 453,756 07:50:36 INFO - TinderboxPrint: CPU idle
8,284.9 (86.7%) 07:50:36 INFO - TinderboxPrint: CPU user
1,219.6 (12.8%) 07:50:36 INFO - TinderboxPrint: Swap in / out
0 / 0 07:50:36 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 253517824; Read time: 0; Write time: 289796 07:50:36 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 300093440; Read time: 0; Write time: 163960 07:50:36 INFO - Running post-run listener: _upload_blobber_files 07:50:36 INFO - Blob upload gear active. 07:50:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:50:36 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:50:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:50:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:50:37 INFO - (blobuploader) - INFO - Open directory for files ... 07:50:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:50:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:50:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:37 INFO - (blobuploader) - INFO - Done attempting. 07:50:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:50:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:50:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:41 INFO - (blobuploader) - INFO - Done attempting. 07:50:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:50:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:50:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:50:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:50:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:50:41 INFO - (blobuploader) - INFO - Done attempting. 07:50:41 INFO - (blobuploader) - INFO - Iteration through files over. 07:50:41 INFO - Return code: 0 07:50:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:50:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:50:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d8eb017904d8b08f8602302ff341f05d8622ad49a8a648c0a7e0ad6e5041956b75d4f4863d8a5c8193e7345554f14d0cb6b10a11e1d3d7823999fcdcacd5349e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82a385c4d411f34ae3c2082eba64bdd17d0a2b7ffa73df6c105243d4aca724a46dd2134cca46e435ff0652ae09768c2f44a07903463b2350aa1abdb08427d320", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f4148c727238e41d607c74cc007451440aaa545f04b7fce3771cc1daaf4319b09f8a66f712ee4041ef58198651cb80e47209b721a600017ff9b83d8524bb5de8"} 07:50:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:50:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:50:41 INFO - Contents: 07:50:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d8eb017904d8b08f8602302ff341f05d8622ad49a8a648c0a7e0ad6e5041956b75d4f4863d8a5c8193e7345554f14d0cb6b10a11e1d3d7823999fcdcacd5349e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82a385c4d411f34ae3c2082eba64bdd17d0a2b7ffa73df6c105243d4aca724a46dd2134cca46e435ff0652ae09768c2f44a07903463b2350aa1abdb08427d320", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f4148c727238e41d607c74cc007451440aaa545f04b7fce3771cc1daaf4319b09f8a66f712ee4041ef58198651cb80e47209b721a600017ff9b83d8524bb5de8"} 07:50:41 INFO - Running post-run listener: copy_logs_to_upload_dir 07:50:41 INFO - Copying logs to upload dir... 07:50:41 INFO - mkdir: /builds/slave/test/build/upload/logs 07:50:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.128718 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-07 07:50:41.734141) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 07:50:41.738924) ========= 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=d2a8c569965ab8367867b893000001a1-1467900892.62644-766203591 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-Non-PGO/sha512/d8eb017904d8b08f8602302ff341f05d8622ad49a8a648c0a7e0ad6e5041956b75d4f4863d8a5c8193e7345554f14d0cb6b10a11e1d3d7823999fcdcacd5349e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82a385c4d411f34ae3c2082eba64bdd17d0a2b7ffa73df6c105243d4aca724a46dd2134cca46e435ff0652ae09768c2f44a07903463b2350aa1abdb08427d320", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f4148c727238e41d607c74cc007451440aaa545f04b7fce3771cc1daaf4319b09f8a66f712ee4041ef58198651cb80e47209b721a600017ff9b83d8524bb5de8"} build_url:https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011170 build_url: 'https://queue.taskcluster.net/v1/task/UFErZw_2Ttu65Pje2xP5wQ/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-Non-PGO/sha512/d8eb017904d8b08f8602302ff341f05d8622ad49a8a648c0a7e0ad6e5041956b75d4f4863d8a5c8193e7345554f14d0cb6b10a11e1d3d7823999fcdcacd5349e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/82a385c4d411f34ae3c2082eba64bdd17d0a2b7ffa73df6c105243d4aca724a46dd2134cca46e435ff0652ae09768c2f44a07903463b2350aa1abdb08427d320", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f4148c727238e41d607c74cc007451440aaa545f04b7fce3771cc1daaf4319b09f8a66f712ee4041ef58198651cb80e47209b721a600017ff9b83d8524bb5de8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 07:50:41.766771) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 07:50:41.767100) ========= 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=d2a8c569965ab8367867b893000001a1-1467900892.62644-766203591 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 07:50:41.849440) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 07:50:41.852902) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 07:50:41.853274) ========= ========= Total master_lag: 0.19 =========