builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-012 starttime: 1468920353.42 results: success (0) buildid: 20160719013121 builduid: d494340279314526a5e6c548046be8b4 revision: 48d51227912b8ec3600758d59a995521e2fbea1c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 02:25:53.419139) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 02:25:53.419660) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 02:25:53.419933) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 02:25:53.434722) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 02:25:53.435101) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-19 02:25:53-- 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% 70.6M=0s 2016-07-19 02:25:54 (70.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.065432 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 02:25:53.514607) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 02:25:53.514915) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021164 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 02:25:53.565025) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 02:25:53.565407) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 48d51227912b8ec3600758d59a995521e2fbea1c --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 48d51227912b8ec3600758d59a995521e2fbea1c --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=2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-19 02:25:54,128 truncating revision to first 12 chars 2016-07-19 02:25:54,129 Setting DEBUG logging. 2016-07-19 02:25:54,129 attempt 1/10 2016-07-19 02:25:54,129 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/48d51227912b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 02:25:54,597 unpacking tar archive at: fx-team-48d51227912b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.811807 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 02:25:54.390717) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 02:25:54.391037) ========= script_repo_revision: 48d51227912b8ec3600758d59a995521e2fbea1c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 02:25:54.391447) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 02:25:54.391723) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 02:25:54.399806) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-19 02:25:54.400135) ========= /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=2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:25:55 INFO - MultiFileLogger online at 20160719 02:25:55 in /builds/slave/test 02:25:55 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 02:25:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:25:55 INFO - {'append_to_log': False, 02:25:55 INFO - 'base_work_dir': '/builds/slave/test', 02:25:55 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 02:25:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:25:55 INFO - 'branch': 'Fx-Team-Non-PGO', 02:25:55 INFO - 'buildbot_json_path': 'buildprops.json', 02:25:55 INFO - 'config_files': ('talos/linux_config.py',), 02:25:55 INFO - 'default_actions': ('clobber', 02:25:55 INFO - 'read-buildbot-config', 02:25:55 INFO - 'download-and-extract', 02:25:55 INFO - 'populate-webroot', 02:25:55 INFO - 'create-virtualenv', 02:25:55 INFO - 'install', 02:25:55 INFO - 'run-tests'), 02:25:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:25:55 INFO - 'download_minidump_stackwalk': True, 02:25:55 INFO - 'download_symbols': 'ondemand', 02:25:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:25:55 INFO - 'tooltool.py': '/tools/tooltool.py', 02:25:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:25:55 INFO - '/tools/misc-python/virtualenv.py')}, 02:25:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:25:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:25:55 INFO - 'installer_path': 'installer.exe', 02:25:55 INFO - 'log_level': 'info', 02:25:55 INFO - 'log_name': 'talos', 02:25:55 INFO - 'log_to_console': True, 02:25:55 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:25:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:25:55 INFO - 'opt_config_files': (), 02:25:55 INFO - 'pip_index': False, 02:25:55 INFO - 'sps_profile': False, 02:25:55 INFO - 'sps_profile_interval': 0, 02:25:55 INFO - 'suite': 'dromaeojs-e10s', 02:25:55 INFO - 'system_bits': '32', 02:25:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:25:55 INFO - 'title': 'talos-linux64-ix-012', 02:25:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:25:55 INFO - 'use_talos_json': True, 02:25:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:25:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:25:55 INFO - 'work_dir': 'build'} 02:25:55 INFO - ##### 02:25:55 INFO - ##### Running clobber step. 02:25:55 INFO - ##### 02:25:55 INFO - Running pre-action listener: _resource_record_pre_action 02:25:55 INFO - Running main action method: clobber 02:25:55 INFO - rmtree: /builds/slave/test/build 02:25:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:25:55 INFO - Running post-action listener: _resource_record_post_action 02:25:55 INFO - ##### 02:25:55 INFO - ##### Finished clobber step (success) 02:25:55 INFO - ##### 02:25:55 INFO - ##### 02:25:55 INFO - ##### Running read-buildbot-config step. 02:25:55 INFO - ##### 02:25:55 INFO - Running pre-action listener: _resource_record_pre_action 02:25:55 INFO - Running main action method: read_buildbot_config 02:25:55 INFO - Using buildbot properties: 02:25:55 INFO - { 02:25:55 INFO - "project": "", 02:25:55 INFO - "product": "firefox", 02:25:55 INFO - "script_repo_revision": "production", 02:25:55 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 02:25:55 INFO - "repository": "", 02:25:55 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 02:25:55 INFO - "buildid": "20160719013121", 02:25:55 INFO - "pgo_build": "False", 02:25:55 INFO - "basedir": "/builds/slave/test", 02:25:55 INFO - "buildnumber": 1673, 02:25:55 INFO - "slavename": "talos-linux64-ix-012", 02:25:55 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:25:55 INFO - "platform": "ubuntu64_hw", 02:25:55 INFO - "scheduler": "tests-fx-team-linux64-talos", 02:25:55 INFO - "branch": "fx-team", 02:25:55 INFO - "repo_path": "integration/fx-team", 02:25:55 INFO - "revision": "48d51227912b8ec3600758d59a995521e2fbea1c", 02:25:55 INFO - "stage_platform": "linux64", 02:25:55 INFO - "builduid": "d494340279314526a5e6c548046be8b4", 02:25:55 INFO - "slavebuilddir": "test" 02:25:55 INFO - } 02:25:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/DLN5MBsCTZGv47sNJstPkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:25:55 INFO - Running post-action listener: _resource_record_post_action 02:25:55 INFO - ##### 02:25:55 INFO - ##### Finished read-buildbot-config step (success) 02:25:55 INFO - ##### 02:25:55 INFO - ##### 02:25:55 INFO - ##### Running download-and-extract step. 02:25:55 INFO - ##### 02:25:55 INFO - Running pre-action listener: _resource_record_pre_action 02:25:55 INFO - Running main action method: download_and_extract 02:25:55 INFO - mkdir: /builds/slave/test/build/tests 02:25:55 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')]} 02:25:55 INFO - https://queue.taskcluster.net/v1/task/DLN5MBsCTZGv47sNJstPkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:25:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DLN5MBsCTZGv47sNJstPkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:25:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DLN5MBsCTZGv47sNJstPkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:25:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DLN5MBsCTZGv47sNJstPkQ/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 02:25:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DLN5MBsCTZGv47sNJstPkQ/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 02:25:56 INFO - Downloaded 1361 bytes. 02:25:56 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:25:56 INFO - Using the following test package requirements: 02:25:56 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:25:56 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:25:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:25:56 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:25:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:25:56 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:25:56 INFO - u'jsshell-linux-x86_64.zip'], 02:25:56 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:25:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:25:56 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:25:56 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:25:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:25:56 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:25:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:25:56 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:25:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:25:56 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:25:56 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:25:56 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:56 INFO - https://queue.taskcluster.net/v1/task/DLN5MBsCTZGv47sNJstPkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:25:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DLN5MBsCTZGv47sNJstPkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:25:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DLN5MBsCTZGv47sNJstPkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:25:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DLN5MBsCTZGv47sNJstPkQ/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 02:25:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DLN5MBsCTZGv47sNJstPkQ/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 02:25:57 INFO - Downloaded 22763363 bytes. 02:25:57 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'] 02:25:57 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 02:25:58 INFO - Return code: 0 02:25:58 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 02:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:25:58 INFO - https://queue.taskcluster.net/v1/task/DLN5MBsCTZGv47sNJstPkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:25:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DLN5MBsCTZGv47sNJstPkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:25:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DLN5MBsCTZGv47sNJstPkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:25:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DLN5MBsCTZGv47sNJstPkQ/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 02:25:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DLN5MBsCTZGv47sNJstPkQ/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 02:26:00 INFO - Downloaded 22763363 bytes. 02:26:00 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'] 02:26:00 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 02:26:01 INFO - Return code: 0 02:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:01 INFO - https://queue.taskcluster.net/v1/task/DLN5MBsCTZGv47sNJstPkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:26:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DLN5MBsCTZGv47sNJstPkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:26:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DLN5MBsCTZGv47sNJstPkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:26:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DLN5MBsCTZGv47sNJstPkQ/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 02:26:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DLN5MBsCTZGv47sNJstPkQ/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 02:26:02 INFO - Downloaded 14403317 bytes. 02:26:02 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'] 02:26:02 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 02:26:02 INFO - Return code: 0 02:26:02 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')]} 02:26:02 INFO - https://queue.taskcluster.net/v1/task/DLN5MBsCTZGv47sNJstPkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:26:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DLN5MBsCTZGv47sNJstPkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:26:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DLN5MBsCTZGv47sNJstPkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:26:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DLN5MBsCTZGv47sNJstPkQ/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 02:26:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/DLN5MBsCTZGv47sNJstPkQ/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 02:26:04 INFO - Downloaded 57129138 bytes. 02:26:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DLN5MBsCTZGv47sNJstPkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:26:04 INFO - mkdir: /builds/slave/test/properties 02:26:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:26:04 INFO - Writing to file /builds/slave/test/properties/build_url 02:26:04 INFO - Contents: 02:26:04 INFO - build_url:https://queue.taskcluster.net/v1/task/DLN5MBsCTZGv47sNJstPkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:26:04 INFO - Running post-action listener: _resource_record_post_action 02:26:04 INFO - Running post-action listener: set_extra_try_arguments 02:26:04 INFO - ##### 02:26:04 INFO - ##### Finished download-and-extract step (success) 02:26:04 INFO - ##### 02:26:04 INFO - ##### 02:26:04 INFO - ##### Running populate-webroot step. 02:26:04 INFO - ##### 02:26:04 INFO - Running pre-action listener: _resource_record_pre_action 02:26:04 INFO - Running main action method: populate_webroot 02:26:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:26:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:26:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:26:04 INFO - '--tppagecycles', 02:26:04 INFO - '7'], 02:26:04 INFO - 'tests': ['tsvgm']}}, 02:26:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:26:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:26:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:26:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:26:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:26:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:26:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:04 INFO - 'talos_options': ['--disable-e10s'], 02:26:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:26:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:26:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:04 INFO - 'talos_options': ['--disable-e10s'], 02:26:04 INFO - 'tests': ['damp', 'tps']}, 02:26:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:04 INFO - 'tests': ['damp', 'tps']}, 02:26:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:26:04 INFO - 'tests': ['dromaeo_dom']}, 02:26:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:26:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:26:04 INFO - 'tests': ['basic_compositor_video']}, 02:26:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:26:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:26:04 INFO - 'tests': ['a11yr', 02:26:04 INFO - 'ts_paint', 02:26:04 INFO - 'tpaint', 02:26:04 INFO - 'sessionrestore', 02:26:04 INFO - 'sessionrestore_no_auto_restore', 02:26:04 INFO - 'tabpaint']}, 02:26:04 INFO - 'other-e10s': {'tests': ['a11yr', 02:26:04 INFO - 'ts_paint', 02:26:04 INFO - 'tpaint', 02:26:04 INFO - 'sessionrestore', 02:26:04 INFO - 'sessionrestore_no_auto_restore', 02:26:04 INFO - 'tabpaint']}, 02:26:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:26:04 INFO - 'ts_paint', 02:26:04 INFO - 'tpaint', 02:26:04 INFO - 'sessionrestore', 02:26:04 INFO - 'sessionrestore_no_auto_restore', 02:26:04 INFO - 'tabpaint']}, 02:26:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:26:04 INFO - 'ts_paint', 02:26:04 INFO - 'tpaint', 02:26:04 INFO - 'sessionrestore', 02:26:04 INFO - 'sessionrestore_no_auto_restore', 02:26:04 INFO - 'tabpaint']}, 02:26:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:26:04 INFO - 'tests': ['a11yr', 02:26:04 INFO - 'ts_paint', 02:26:04 INFO - 'tpaint', 02:26:04 INFO - 'sessionrestore', 02:26:04 INFO - 'sessionrestore_no_auto_restore', 02:26:04 INFO - 'tabpaint']}, 02:26:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:26:04 INFO - 'tests': ['a11yr', 02:26:04 INFO - 'ts_paint', 02:26:04 INFO - 'tpaint', 02:26:04 INFO - 'sessionrestore', 02:26:04 INFO - 'sessionrestore_no_auto_restore', 02:26:04 INFO - 'tabpaint']}, 02:26:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:26:04 INFO - 'tests': ['tsvgx', 02:26:04 INFO - 'tsvgr_opacity', 02:26:04 INFO - 'tart', 02:26:04 INFO - 'tscrollx', 02:26:04 INFO - 'cart']}, 02:26:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:26:04 INFO - 'tsvgr_opacity', 02:26:04 INFO - 'tart', 02:26:04 INFO - 'tscrollx', 02:26:04 INFO - 'cart']}, 02:26:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:04 INFO - 'talos_options': ['--disable-e10s'], 02:26:04 INFO - 'tests': ['tp5o']}, 02:26:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:04 INFO - 'tests': ['tp5o']}, 02:26:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:04 INFO - 'talos_options': ['--disable-e10s', 02:26:04 INFO - '--xperf_path', 02:26:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:26:04 INFO - 'tests': ['tp5n']}, 02:26:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:04 INFO - 'talos_options': ['--xperf_path', 02:26:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:26:04 INFO - 'tests': ['tp5n']}}, 02:26:04 INFO - 'talos.zip': {'path': '', 02:26:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:26:04 INFO - Running post-action listener: _resource_record_post_action 02:26:04 INFO - ##### 02:26:04 INFO - ##### Finished populate-webroot step (success) 02:26:04 INFO - ##### 02:26:04 INFO - ##### 02:26:04 INFO - ##### Running create-virtualenv step. 02:26:04 INFO - ##### 02:26:04 INFO - Running pre-action listener: _resource_record_pre_action 02:26:04 INFO - Running main action method: create_virtualenv 02:26:04 INFO - Creating virtualenv /builds/slave/test/build/venv 02:26:04 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 02:26:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:26:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:26:04 INFO - Using real prefix '/usr' 02:26:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:26:05 INFO - Installing distribute.............................................................................................................................................................................................done. 02:26:07 INFO - Installing pip.................done. 02:26:07 INFO - Return code: 0 02:26:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:26: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')]} 02:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26: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')]} 02:26:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:07 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 0xfeb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a9570>, '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 0x12aa470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12aa900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686', '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 02:26:07 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 02:26:07 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 02:26:07 INFO - Using env: {'DISPLAY': ':0', 02:26:07 INFO - 'HOME': '/home/cltbld', 02:26:07 INFO - 'LANG': 'en_US.UTF-8', 02:26:07 INFO - 'LANGUAGE': 'en_US:en', 02:26:07 INFO - 'LOGNAME': 'cltbld', 02:26:07 INFO - 'MAIL': '/var/mail/cltbld', 02:26:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:07 INFO - 'MOZ_NO_REMOTE': '1', 02:26:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:07 INFO - 'NO_EM_RESTART': '1', 02:26:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:07 INFO - 'PWD': '/builds/slave/test', 02:26:07 INFO - 'SHELL': '/bin/bash', 02:26:07 INFO - 'SHLVL': '1', 02:26:07 INFO - 'TERM': 'linux', 02:26:07 INFO - 'TMOUT': '86400', 02:26:07 INFO - 'USER': 'cltbld', 02:26:07 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686', 02:26:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:07 INFO - '_': '/tools/buildbot/bin/python'} 02:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:07 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 02:26:07 INFO - Cleaning up... 02:26:07 INFO - Return code: 0 02:26:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:26: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')]} 02:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26: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')]} 02:26:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:07 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 0xfeb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a9570>, '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 0x12aa470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12aa900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686', '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 02:26:07 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 02:26:07 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 02:26:07 INFO - Using env: {'DISPLAY': ':0', 02:26:07 INFO - 'HOME': '/home/cltbld', 02:26:07 INFO - 'LANG': 'en_US.UTF-8', 02:26:07 INFO - 'LANGUAGE': 'en_US:en', 02:26:07 INFO - 'LOGNAME': 'cltbld', 02:26:07 INFO - 'MAIL': '/var/mail/cltbld', 02:26:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:07 INFO - 'MOZ_NO_REMOTE': '1', 02:26:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:07 INFO - 'NO_EM_RESTART': '1', 02:26:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:07 INFO - 'PWD': '/builds/slave/test', 02:26:07 INFO - 'SHELL': '/bin/bash', 02:26:07 INFO - 'SHLVL': '1', 02:26:07 INFO - 'TERM': 'linux', 02:26:07 INFO - 'TMOUT': '86400', 02:26:07 INFO - 'USER': 'cltbld', 02:26:07 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686', 02:26:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:07 INFO - '_': '/tools/buildbot/bin/python'} 02:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:07 INFO - Downloading/unpacking psutil>=3.1.1 02:26:07 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 02:26:07 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 02:26:07 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 02:26:07 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 02:26:07 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 02:26:07 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 02:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:26:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:26:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:26:09 INFO - Installing collected packages: psutil 02:26:09 INFO - Running setup.py install for psutil 02:26:10 INFO - building 'psutil._psutil_linux' extension 02:26:10 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 02:26:10 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 02:26:10 INFO - building 'psutil._psutil_posix' extension 02:26:10 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 02:26:10 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 02:26:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:26:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:26:10 INFO - Successfully installed psutil 02:26:10 INFO - Cleaning up... 02:26:10 INFO - Return code: 0 02:26:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:26: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')]} 02:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26: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')]} 02:26:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:10 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 0xfeb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a9570>, '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 0x12aa470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12aa900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686', '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 02:26:10 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 02:26:10 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 02:26:10 INFO - Using env: {'DISPLAY': ':0', 02:26:10 INFO - 'HOME': '/home/cltbld', 02:26:10 INFO - 'LANG': 'en_US.UTF-8', 02:26:10 INFO - 'LANGUAGE': 'en_US:en', 02:26:10 INFO - 'LOGNAME': 'cltbld', 02:26:10 INFO - 'MAIL': '/var/mail/cltbld', 02:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:10 INFO - 'MOZ_NO_REMOTE': '1', 02:26:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:10 INFO - 'NO_EM_RESTART': '1', 02:26:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:10 INFO - 'PWD': '/builds/slave/test', 02:26:10 INFO - 'SHELL': '/bin/bash', 02:26:10 INFO - 'SHLVL': '1', 02:26:10 INFO - 'TERM': 'linux', 02:26:10 INFO - 'TMOUT': '86400', 02:26:10 INFO - 'USER': 'cltbld', 02:26:10 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686', 02:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:10 INFO - '_': '/tools/buildbot/bin/python'} 02:26:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:26:10 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 02:26:10 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 02:26:10 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 02:26:10 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 02:26:10 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 02:26:10 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 02:26:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:26:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:26:12 INFO - Installing collected packages: mozsystemmonitor 02:26:12 INFO - Running setup.py install for mozsystemmonitor 02:26:12 INFO - Successfully installed mozsystemmonitor 02:26:12 INFO - Cleaning up... 02:26:12 INFO - Return code: 0 02:26:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:26: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')]} 02:26:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26: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')]} 02:26:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:12 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 0xfeb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a9570>, '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 0x12aa470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12aa900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686', '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 02:26:12 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 02:26:12 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 02:26:12 INFO - Using env: {'DISPLAY': ':0', 02:26:12 INFO - 'HOME': '/home/cltbld', 02:26:12 INFO - 'LANG': 'en_US.UTF-8', 02:26:12 INFO - 'LANGUAGE': 'en_US:en', 02:26:12 INFO - 'LOGNAME': 'cltbld', 02:26:12 INFO - 'MAIL': '/var/mail/cltbld', 02:26:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:12 INFO - 'MOZ_NO_REMOTE': '1', 02:26:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:12 INFO - 'NO_EM_RESTART': '1', 02:26:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:12 INFO - 'PWD': '/builds/slave/test', 02:26:12 INFO - 'SHELL': '/bin/bash', 02:26:12 INFO - 'SHLVL': '1', 02:26:12 INFO - 'TERM': 'linux', 02:26:12 INFO - 'TMOUT': '86400', 02:26:12 INFO - 'USER': 'cltbld', 02:26:12 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686', 02:26:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:12 INFO - '_': '/tools/buildbot/bin/python'} 02:26:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:13 INFO - Downloading/unpacking jsonschema==2.5.1 02:26:13 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 02:26:13 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 02:26:13 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 02:26:13 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 02:26:13 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 02:26:13 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 02:26:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:26:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:15 INFO - Downloading functools32-3.2.3-2.tar.gz 02:26:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:26:15 INFO - warning: no files found matching '*.txt' 02:26:15 INFO - no previously-included directories found matching 'build' 02:26:15 INFO - no previously-included directories found matching 'dist' 02:26:15 INFO - no previously-included directories found matching '.git*' 02:26:15 INFO - Installing collected packages: jsonschema, functools32 02:26:15 INFO - Running setup.py install for functools32 02:26:15 INFO - warning: no files found matching '*.txt' 02:26:15 INFO - no previously-included directories found matching 'build' 02:26:15 INFO - no previously-included directories found matching 'dist' 02:26:15 INFO - no previously-included directories found matching '.git*' 02:26:15 INFO - Successfully installed jsonschema functools32 02:26:15 INFO - Cleaning up... 02:26:15 INFO - Return code: 0 02:26:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:26:15 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')]} 02:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:15 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')]} 02:26:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:15 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 0xfeb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a9570>, '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 0x12aa470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12aa900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686', '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 02:26:15 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 02:26:15 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 02:26:15 INFO - Using env: {'DISPLAY': ':0', 02:26:15 INFO - 'HOME': '/home/cltbld', 02:26:15 INFO - 'LANG': 'en_US.UTF-8', 02:26:15 INFO - 'LANGUAGE': 'en_US:en', 02:26:15 INFO - 'LOGNAME': 'cltbld', 02:26:15 INFO - 'MAIL': '/var/mail/cltbld', 02:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:15 INFO - 'MOZ_NO_REMOTE': '1', 02:26:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:15 INFO - 'NO_EM_RESTART': '1', 02:26:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:15 INFO - 'PWD': '/builds/slave/test', 02:26:15 INFO - 'SHELL': '/bin/bash', 02:26:15 INFO - 'SHLVL': '1', 02:26:15 INFO - 'TERM': 'linux', 02:26:15 INFO - 'TMOUT': '86400', 02:26:15 INFO - 'USER': 'cltbld', 02:26:15 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686', 02:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:15 INFO - '_': '/tools/buildbot/bin/python'} 02:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:15 INFO - Downloading/unpacking blobuploader==1.2.4 02:26:15 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 02:26:15 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 02:26:15 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 02:26:15 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 02:26:15 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 02:26:15 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 02:26:17 INFO - Downloading blobuploader-1.2.4.tar.gz 02:26:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:26:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:26:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:26:18 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 02:26:18 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 02:26:18 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 02:26:18 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 02:26:18 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 02:26:18 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 02:26:18 INFO - Downloading docopt-0.6.1.tar.gz 02:26:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:26:18 INFO - Installing collected packages: blobuploader, requests, docopt 02:26:18 INFO - Running setup.py install for blobuploader 02:26:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:26:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:26:18 INFO - Running setup.py install for requests 02:26:18 INFO - Running setup.py install for docopt 02:26:18 INFO - Successfully installed blobuploader requests docopt 02:26:18 INFO - Cleaning up... 02:26:18 INFO - Return code: 0 02:26:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26: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')]} 02:26:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26: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')]} 02:26:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:18 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 0xfeb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a9570>, '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 0x12aa470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12aa900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686', '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 02:26:18 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 02:26:18 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 02:26:18 INFO - Using env: {'DISPLAY': ':0', 02:26:18 INFO - 'HOME': '/home/cltbld', 02:26:18 INFO - 'LANG': 'en_US.UTF-8', 02:26:18 INFO - 'LANGUAGE': 'en_US:en', 02:26:18 INFO - 'LOGNAME': 'cltbld', 02:26:18 INFO - 'MAIL': '/var/mail/cltbld', 02:26:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:18 INFO - 'MOZ_NO_REMOTE': '1', 02:26:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:18 INFO - 'NO_EM_RESTART': '1', 02:26:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:18 INFO - 'PWD': '/builds/slave/test', 02:26:18 INFO - 'SHELL': '/bin/bash', 02:26:18 INFO - 'SHLVL': '1', 02:26:18 INFO - 'TERM': 'linux', 02:26:18 INFO - 'TMOUT': '86400', 02:26:18 INFO - 'USER': 'cltbld', 02:26:18 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686', 02:26:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:18 INFO - '_': '/tools/buildbot/bin/python'} 02:26:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:26:19 INFO - Running setup.py (path:/tmp/pip-gL5qqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:26:19 INFO - Running setup.py (path:/tmp/pip-igctlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:26:19 INFO - Running setup.py (path:/tmp/pip-0m5Z2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:26:19 INFO - Running setup.py (path:/tmp/pip-2xbs0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:26:19 INFO - Running setup.py (path:/tmp/pip-hJFOud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:26:19 INFO - Running setup.py (path:/tmp/pip-yFn14Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:26:19 INFO - Running setup.py (path:/tmp/pip-cdXbhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:26:19 INFO - Running setup.py (path:/tmp/pip-sgXdJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:26:19 INFO - Running setup.py (path:/tmp/pip-FcXYYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:26:19 INFO - Running setup.py (path:/tmp/pip-tPRoGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:26:19 INFO - Running setup.py (path:/tmp/pip-DNhGb7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:26:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:26:19 INFO - Running setup.py (path:/tmp/pip-uSqpPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:26:20 INFO - Running setup.py (path:/tmp/pip-PBMThj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:26:20 INFO - Running setup.py (path:/tmp/pip-ug1F8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:20 INFO - Running setup.py (path:/tmp/pip-NS6AaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:26:20 INFO - Running setup.py (path:/tmp/pip-sYcMwC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:26:20 INFO - Running setup.py (path:/tmp/pip-PGwN2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:26:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:26:20 INFO - Running setup.py install for manifestparser 02:26:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:26:20 INFO - Running setup.py install for mozcrash 02:26:20 INFO - Running setup.py install for mozdebug 02:26:20 INFO - Running setup.py install for mozdevice 02:26:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:26:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:26:20 INFO - Running setup.py install for mozfile 02:26:20 INFO - Running setup.py install for mozhttpd 02:26:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:26:21 INFO - Running setup.py install for mozinfo 02:26:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:26:21 INFO - Running setup.py install for mozInstall 02:26:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:26:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:26:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:26:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:26:21 INFO - Running setup.py install for mozleak 02:26:21 INFO - Running setup.py install for mozlog 02:26:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:26:21 INFO - Running setup.py install for moznetwork 02:26:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:26:21 INFO - Running setup.py install for mozprocess 02:26:21 INFO - Running setup.py install for mozprofile 02:26:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:26:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:26:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:26:21 INFO - Running setup.py install for mozrunner 02:26:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:26:21 INFO - Running setup.py install for mozscreenshot 02:26:21 INFO - Running setup.py install for moztest 02:26:22 INFO - Running setup.py install for mozversion 02:26:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:26:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:26:22 INFO - Cleaning up... 02:26:22 INFO - Return code: 0 02:26:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26:22 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')]} 02:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:22 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')]} 02:26:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:22 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 0xfeb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a9570>, '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 0x12aa470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12aa900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686', '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 02:26:22 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 02:26:22 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 02:26:22 INFO - Using env: {'DISPLAY': ':0', 02:26:22 INFO - 'HOME': '/home/cltbld', 02:26:22 INFO - 'LANG': 'en_US.UTF-8', 02:26:22 INFO - 'LANGUAGE': 'en_US:en', 02:26:22 INFO - 'LOGNAME': 'cltbld', 02:26:22 INFO - 'MAIL': '/var/mail/cltbld', 02:26:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:22 INFO - 'MOZ_NO_REMOTE': '1', 02:26:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:22 INFO - 'NO_EM_RESTART': '1', 02:26:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:22 INFO - 'PWD': '/builds/slave/test', 02:26:22 INFO - 'SHELL': '/bin/bash', 02:26:22 INFO - 'SHLVL': '1', 02:26:22 INFO - 'TERM': 'linux', 02:26:22 INFO - 'TMOUT': '86400', 02:26:22 INFO - 'USER': 'cltbld', 02:26:22 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686', 02:26:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:22 INFO - '_': '/tools/buildbot/bin/python'} 02:26:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:26:22 INFO - Running setup.py (path:/tmp/pip-7cQ0Jv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:26:22 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)) 02:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:26:22 INFO - Running setup.py (path:/tmp/pip-vtZ1jq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:26:22 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)) 02:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:26:22 INFO - Running setup.py (path:/tmp/pip-CN0WPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:26:22 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)) 02:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:26:22 INFO - Running setup.py (path:/tmp/pip-TqT9Rb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:26:22 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)) 02:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:26:22 INFO - Running setup.py (path:/tmp/pip-0ZOB5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:26:22 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)) 02:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:26:22 INFO - Running setup.py (path:/tmp/pip-eKPzxO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:26:22 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)) 02:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:26:22 INFO - Running setup.py (path:/tmp/pip-8xLuNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:26:22 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)) 02:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:26:22 INFO - Running setup.py (path:/tmp/pip-uyCvqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:26:23 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)) 02:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:26:23 INFO - Running setup.py (path:/tmp/pip-cF9e9Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:26:23 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)) 02:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:26:23 INFO - Running setup.py (path:/tmp/pip-wzrQ0T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:26:23 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)) 02:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:26:23 INFO - Running setup.py (path:/tmp/pip-1xq_3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:26:23 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)) 02:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:26:23 INFO - Running setup.py (path:/tmp/pip-KJ0Rsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:26:23 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)) 02:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:26:23 INFO - Running setup.py (path:/tmp/pip-CtJUMh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:26:23 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)) 02:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:26:23 INFO - Running setup.py (path:/tmp/pip-9Tbtm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:26:23 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)) 02:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:23 INFO - Running setup.py (path:/tmp/pip-6qdUR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:26:23 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)) 02:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:26:23 INFO - Running setup.py (path:/tmp/pip-vqoDvu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:26:23 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)) 02:26:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:26:23 INFO - Running setup.py (path:/tmp/pip-Lnb3bg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:26:23 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)) 02:26:23 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)) 02:26:23 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)) 02:26:23 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)) 02:26:23 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)) 02:26:23 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)) 02:26:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:26:23 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 02:26:23 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 02:26:23 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 02:26:23 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 02:26:23 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 02:26:23 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 02:26:25 INFO - Downloading blessings-1.6.tar.gz 02:26:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:26:25 INFO - Installing collected packages: blessings 02:26:25 INFO - Running setup.py install for blessings 02:26:25 INFO - Successfully installed blessings 02:26:25 INFO - Cleaning up... 02:26:25 INFO - Return code: 0 02:26:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:26:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:26:26 INFO - Reading from file tmpfile_stdout 02:26:26 INFO - Current package versions: 02:26:26 INFO - argparse == 1.2.1 02:26:26 INFO - blessings == 1.6 02:26:26 INFO - blobuploader == 1.2.4 02:26:26 INFO - docopt == 0.6.1 02:26:26 INFO - functools32 == 3.2.3-2 02:26:26 INFO - jsonschema == 2.5.1 02:26:26 INFO - manifestparser == 1.1 02:26:26 INFO - mozInstall == 1.12 02:26:26 INFO - mozcrash == 0.17 02:26:26 INFO - mozdebug == 0.1 02:26:26 INFO - mozdevice == 0.48 02:26:26 INFO - mozfile == 1.2 02:26:26 INFO - mozhttpd == 0.7 02:26:26 INFO - mozinfo == 0.9 02:26:26 INFO - mozleak == 0.1 02:26:26 INFO - mozlog == 3.2 02:26:26 INFO - moznetwork == 0.27 02:26:26 INFO - mozprocess == 0.23 02:26:26 INFO - mozprofile == 0.28 02:26:26 INFO - mozrunner == 6.12 02:26:26 INFO - mozscreenshot == 0.1 02:26:26 INFO - mozsystemmonitor == 0.3 02:26:26 INFO - moztest == 0.7 02:26:26 INFO - mozversion == 1.4 02:26:26 INFO - psutil == 3.1.1 02:26:26 INFO - requests == 1.2.3 02:26:26 INFO - wsgiref == 0.1.2 02:26:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:26: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')]} 02:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26: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')]} 02:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:26 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 0xfeb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a9570>, '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 0x12aa470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12aa900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686', '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 02:26:26 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 02:26:26 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 02:26:26 INFO - Using env: {'DISPLAY': ':0', 02:26:26 INFO - 'HOME': '/home/cltbld', 02:26:26 INFO - 'LANG': 'en_US.UTF-8', 02:26:26 INFO - 'LANGUAGE': 'en_US:en', 02:26:26 INFO - 'LOGNAME': 'cltbld', 02:26:26 INFO - 'MAIL': '/var/mail/cltbld', 02:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:26 INFO - 'MOZ_NO_REMOTE': '1', 02:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:26 INFO - 'NO_EM_RESTART': '1', 02:26:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:26 INFO - 'PWD': '/builds/slave/test', 02:26:26 INFO - 'SHELL': '/bin/bash', 02:26:26 INFO - 'SHLVL': '1', 02:26:26 INFO - 'TERM': 'linux', 02:26:26 INFO - 'TMOUT': '86400', 02:26:26 INFO - 'USER': 'cltbld', 02:26:26 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686', 02:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:26 INFO - '_': '/tools/buildbot/bin/python'} 02:26:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:26 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)) 02:26:26 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)) 02:26:26 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)) 02:26:26 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)) 02:26:26 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)) 02:26:26 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)) 02:26:26 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)) 02:26:26 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)) 02:26:26 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)) 02:26:26 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)) 02:26:26 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)) 02:26:26 INFO - Cleaning up... 02:26:26 INFO - Return code: 0 02:26:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:26: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')]} 02:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26: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')]} 02:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfeb030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x114e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x121a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a9570>, '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 0x12aa470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12aa900>, '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': '2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686', '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 02:26: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', 'jsonschema'] in /builds/slave/test/build 02:26: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 jsonschema 02:26:26 INFO - Using env: {'DISPLAY': ':0', 02:26:26 INFO - 'HOME': '/home/cltbld', 02:26:26 INFO - 'LANG': 'en_US.UTF-8', 02:26:26 INFO - 'LANGUAGE': 'en_US:en', 02:26:26 INFO - 'LOGNAME': 'cltbld', 02:26:26 INFO - 'MAIL': '/var/mail/cltbld', 02:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:26 INFO - 'MOZ_NO_REMOTE': '1', 02:26:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:26 INFO - 'NO_EM_RESTART': '1', 02:26:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:26 INFO - 'PWD': '/builds/slave/test', 02:26:26 INFO - 'SHELL': '/bin/bash', 02:26:26 INFO - 'SHLVL': '1', 02:26:26 INFO - 'TERM': 'linux', 02:26:26 INFO - 'TMOUT': '86400', 02:26:26 INFO - 'USER': 'cltbld', 02:26:26 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686', 02:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:26 INFO - '_': '/tools/buildbot/bin/python'} 02:26:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:26:26 INFO - Cleaning up... 02:26:26 INFO - Return code: 0 02:26:26 INFO - Running post-action listener: _resource_record_post_action 02:26:26 INFO - Running post-action listener: _start_resource_monitoring 02:26:26 INFO - Starting resource monitoring. 02:26:26 INFO - ##### 02:26:26 INFO - ##### Finished create-virtualenv step (success) 02:26:26 INFO - ##### 02:26:26 INFO - ##### 02:26:26 INFO - ##### Running install step. 02:26:26 INFO - ##### 02:26:26 INFO - Running pre-action listener: _resource_record_pre_action 02:26:26 INFO - Running main action method: install 02:26:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:26:26 INFO - Reading from file tmpfile_stdout 02:26:26 INFO - Detecting whether we're running mozinstall >=1.0... 02:26:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:26:26 INFO - Reading from file tmpfile_stdout 02:26:26 INFO - Output received: 02:26:26 INFO - Usage: mozinstall [options] installer 02:26:26 INFO - Options: 02:26:26 INFO - -h, --help show this help message and exit 02:26:26 INFO - -d DEST, --destination=DEST 02:26:26 INFO - Directory to install application into. [default: 02:26:26 INFO - "/builds/slave/test"] 02:26:26 INFO - --app=APP Application being installed. [default: firefox] 02:26:26 INFO - mkdir: /builds/slave/test/build/application 02:26:26 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'] 02:26:26 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 02:26:43 INFO - Reading from file tmpfile_stdout 02:26:43 INFO - Output received: 02:26:43 INFO - /builds/slave/test/build/application/firefox/firefox 02:26:43 INFO - Running post-action listener: _resource_record_post_action 02:26:43 INFO - ##### 02:26:43 INFO - ##### Finished install step (success) 02:26:43 INFO - ##### 02:26:43 INFO - ##### 02:26:43 INFO - ##### Running run-tests step. 02:26:43 INFO - ##### 02:26:43 INFO - Running pre-action listener: _resource_record_pre_action 02:26:43 INFO - Running main action method: run_tests 02:26:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:26:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:26:43 INFO - Python 2.7.3 02:26:43 INFO - Return code: 0 02:26:43 INFO - grabbing minidump binary from tooltool 02:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:26:43 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 0x12a9570>, '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 0x12aa470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12aa900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:26:43 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 02:26:43 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 02:26:43 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 02:26:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:26:43 INFO - Return code: 0 02:26:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:26:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:26:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:26:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:26:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:26:43 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/DLN5MBsCTZGv47sNJstPkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 02:26:43 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/DLN5MBsCTZGv47sNJstPkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-012 --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 02:26:43 INFO - Using env: {'DISPLAY': ':0', 02:26:43 INFO - 'HOME': '/home/cltbld', 02:26:43 INFO - 'LANG': 'en_US.UTF-8', 02:26:43 INFO - 'LANGUAGE': 'en_US:en', 02:26:43 INFO - 'LOGNAME': 'cltbld', 02:26:43 INFO - 'MAIL': '/var/mail/cltbld', 02:26:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:26:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:43 INFO - 'MOZ_NO_REMOTE': '1', 02:26:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:26:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:43 INFO - 'NO_EM_RESTART': '1', 02:26:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:43 INFO - 'PWD': '/builds/slave/test', 02:26:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:26:43 INFO - 'SHELL': '/bin/bash', 02:26:43 INFO - 'SHLVL': '1', 02:26:43 INFO - 'TERM': 'linux', 02:26:43 INFO - 'TMOUT': '86400', 02:26:43 INFO - 'USER': 'cltbld', 02:26:43 INFO - 'XDG_SESSION_COOKIE': '2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686', 02:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:43 INFO - '_': '/tools/buildbot/bin/python'} 02:26:43 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/DLN5MBsCTZGv47sNJstPkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-012', '--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 02:26:43 INFO - mozversion application_buildid: 20160719013121 02:26:43 INFO - mozversion application_changeset: 48d51227912b8ec3600758d59a995521e2fbea1c 02:26:43 INFO - mozversion application_display_name: Nightly 02:26:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:26:43 INFO - mozversion application_name: Firefox 02:26:43 INFO - mozversion application_remotingname: firefox 02:26:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:26:43 INFO - mozversion application_vendor: Mozilla 02:26:43 INFO - mozversion application_version: 50.0a1 02:26:43 INFO - mozversion platform_buildid: 20160719013121 02:26:43 INFO - mozversion platform_changeset: 48d51227912b8ec3600758d59a995521e2fbea1c 02:26:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:26:43 INFO - mozversion platform_version: 50.0a1 02:26:43 INFO - using testdate: 1468920403 02:26:43 INFO - actual date: 1468920403 02:26:43 INFO - starting webserver on 'localhost:49118' 02:26:43 INFO - SUITE-START | Running 2 tests 02:26:43 INFO - TEST-START | dromaeo_css 02:26:43 INFO - operating with platform_type : linux_ 02:26:43 INFO - Initialising browser for dromaeo_css test... 02:26:43 INFO - TEST-INFO | started process 23338 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMHtYcr/profile http://localhost:49118/getInfo.html) 02:26:47 INFO - PROCESS | 23338 | __metrics Screen width/height:1600/1200 02:26:47 INFO - PROCESS | 23338 | colorDepth:24 02:26:47 INFO - PROCESS | 23338 | Browser inner width/height: 1024/697 02:26:47 INFO - PROCESS | 23338 | __metrics 02:26:48 ERROR - PROCESS | 23338 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 02:26:49 INFO - TEST-INFO | 23338: exit 0 02:26:49 INFO - Browser initialized. 02:26:49 INFO - Running cycle 1/1 for dromaeo_css test... 02:26:49 INFO - TEST-INFO | started process 23459 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMHtYcr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:27:01 INFO - PROCESS | 23459 | RSS: Main: 168710144 02:27:01 INFO - PROCESS | 23459 | 02:27:50 INFO - PROCESS | 23459 | 1468920470850 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] 02:30:03 INFO - PROCESS | 23459 | Cycle 1(1): loaded http://localhost:49118/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49118/tests/dromaeo/cssquery-ext.html) 02:30:04 INFO - PROCESS | 23459 | RSS: Main: 169885696 02:30:04 INFO - PROCESS | 23459 | 02:33:06 INFO - PROCESS | 23459 | Cycle 1(1): loaded http://localhost:49118/tests/dromaeo/cssquery-ext.html (next: http://localhost:49118/tests/dromaeo/cssquery-jquery.html) 02:33:07 INFO - PROCESS | 23459 | RSS: Main: 169103360 02:33:07 INFO - PROCESS | 23459 | 02:36:09 INFO - PROCESS | 23459 | Cycle 1(1): loaded http://localhost:49118/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49118/tests/dromaeo/cssquery-mootools.html) 02:36:09 INFO - PROCESS | 23459 | RSS: Main: 171675648 02:36:09 INFO - PROCESS | 23459 | 02:39:11 INFO - PROCESS | 23459 | Cycle 1(1): loaded http://localhost:49118/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49118/tests/dromaeo/cssquery-prototype.html) 02:39:12 INFO - PROCESS | 23459 | RSS: Main: 166486016 02:39:12 INFO - PROCESS | 23459 | 02:42:15 INFO - PROCESS | 23459 | Cycle 1(1): loaded http://localhost:49118/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49118/tests/dromaeo/cssquery-yui.html) 02:42:16 INFO - PROCESS | 23459 | RSS: Main: 168857600 02:42:16 INFO - PROCESS | 23459 | 02:45:18 INFO - PROCESS | 23459 | Cycle 1(1): loaded http://localhost:49118/tests/dromaeo/cssquery-yui.html (next: http://localhost:49118/tests/dromaeo/cssquery-dojo.html) 02:45:18 INFO - PROCESS | 23459 | RSS: Main: 169353216 02:45:18 INFO - PROCESS | 23459 | 02:45:18 INFO - PROCESS | 23459 | __start_tp_report 02:45:18 INFO - PROCESS | 23459 | _x_x_mozilla_page_load 02:45:18 INFO - PROCESS | 23459 | _x_x_mozilla_page_load_details 02:45:18 INFO - PROCESS | 23459 | |i|pagename|runs| 02:45:18 INFO - PROCESS | 23459 | |0;dojo.html;2641.432092100198;2681.5441374966254;2690.838549687018;2716.8505732184735;2717.320669832542;4794.976025119874;4800.975995120024;4870.293807397929;4877.414710234777;4894.192458244385;4735.3133795599615;4807.447143578481;4812.109759694459;4854.101991131643;4861.878453038676;4398.252297109491;4424.137293227822;4581.564751348633;4582.450105987286;4582.702124361923;410.3409516672911;4254.744715317075;4386.298192289234;4389.056352884129;4496;4388.363687265361;4437.312216606431;4458.041521072985;4474.328850672393;4512.029913568598;4427.623651989585;4464.950736576902;4466.508684044752;4467.687261891669;4500.077484115748;4313.460817397825;4362.192994296033;4380.715253508543;4401.735895846259;4405.911881762347;4749.691270067435;4791.496892826272;4792.448868380111;4793.065352256312;4810.879728006793;4922.581580565657;5067.822626208065;5250.9474905250845;5250.97374513125;5254.106801843657;5085.542301192873;5108.667936584147;5111.05445492585;5111.846644600668;5175.663581867167;4838.080764654705;4845.466998630148;4848.248521479177;4851.708897466164;4904.068227036852;5279.049771041249;5295.628537941651;5332.813351532678;5358.517733404013;5380.950714610613;5158.6131040171385;5172.27588137661;5180.171172612364;5182.6113041521285;5186.792528298825;5278.577713782888;5280.419153893145;5280.709560974184;5281.102212623787;5303.522682958553;4999.100161970808;5005.524475174852;5033.496650334937;5067.4932506749765;5095.31213286209;5010.023045506165;5046.949530504721;5070.467600901926;5085.694858308513;5108.412532558803;4358.694891357574;4362.760048197316;4376.540463251313;4384.758838263926;4413.646908247332;3780;3826.8086595670106;3836.405357169643;3894.337962546374;3894.9221015580097;4516.593506584423;4518.1415531049;4518.254488009507;4563.0873825235085;4603.309503574491;5273.971575542809;5281.735913204325;5285.762140703678;5298.735063246822;5314.4951229633125;4393.648508119343;4452;4494.977525112354;4512.796924138356;4518.051209246095;4662.953370466252;4677.4387073550715;4708.835190768306;4719.244920812654;4760.190767569452;4787.904241915212;4855.95144048555;4866.29438731389;4888.6577939543895;4915.48387419323;5147.948520514897;5209;5216.9739151304;5246.97376513115;5292.391374991926;4880.170371036861;4887.242477416006;4890.951090489192;4892.3884514435695;4948.38145231846;4906.582940450102;5116.258142569232;5129;5139.280500729826;5158.742062896915;5068.366454193226;5145.3568303962;5155.304033955368;5173.042987047408;5181.766820493011;5049.343585333883;5050.974745126251;5074.847754567369;5109.182530795055;5118.872028199325;4913.213885778258;5034.0686972910125;5053.7220452875445;5056.873578160428;5071.18860982241;4990.4011518618;5022.598192144546;5025.623078269071;5066.518680725325;5112.437631860418;5160.200168973815;5181.611379146504;5188.481151884781;5205.219217117463;5219.76511057011;4759.547842955052;4827.468978412442;4863.902721945612;5055.241713742968;5059.671121377099 02:45:18 INFO - PROCESS | 23459 | |1;ext.html;555.5083750880472;572.3160822816734;577.2121054760248;578.667266321865;584.4301805739403;26697.466050679;38940.61059389405;40300.39549406761;40488.595114048854;44485.110297794025;41232.793836030774;41383.58616413835;41547.58452415475;41605.58394416055;41752.58247417525;7746.535207887545;7839.294463498284;7894.526328420285;7905.565193914333;7918.366530677561;7804.882926756075;7935.404844636675;7940.086890007637;7947.841043179133;7960.52236865787;7886.526808391515;7906.80232994174;7915.089764677078;7968.521888686669;7971.800704982393;7894.447388682795;7903.683852645887;7911.129775724695;7914.960425197837;7962.402819788539;7803.531788092732;7838.37293016563;7841;7845.254700803414;7855.685772569091;38393;38871.222575548614;38965.22069558621;39093.21813563741;39264;3127.671594482592;3261.59230096238;3398.320335932823;3501.7373696972827;3757.041954301663;28286.434271314458;28673.713262867313;28735.856320718263;28970.13089607315;29805.10584682463;3080.738137258336;3093.8088835798153;3195.9201019974453;3228.9192770180935;3232.095013396229;250135;250677;252117;252457;252639;31347.84326078355;32496;32557.67442325594;51266.48733512692;52155.73922130365;33422.49866252008;33513.329733405684;33525.32949341;33542.16144596405;33563.496547551804;13671.453141874214;13783.793243101361;13802.654933626538;13822.516211932534;13853.930730346283;11397.430128493543;11521.135914806424;11530.711732206593;11533.653990380302;11565.76868462626;7837.098733645704;7837.333826624801;7851.528908265408;7887.881681774778;7913.129555748863;3084.491058975289;3100.5039193728894;3121.266502371941;3123.7969531980348;3167.2715275486767;809.8015986083448;902.5442151713343;946.6308139825474;948.2366694810605;954.746992047108;27724;27818.860905695747;27981.58027629587;28572.428551428857;28590;960.1646567486332;967.3760424526141;998.8313673002605;1016.2682868334787;1018.1854516387009;14668.559943201508;14861.256937153099;15114.523659558363;15244.618884527754;15320.463783767515;120783;416907;417308;417665;418014;48057.51942480601;49628.25557616639;49649;49780;49819.750901245265;1187.091874715843;1196.3061424374016;1205.957791477294;1207.3600991474532;1213.7754515414854;27138.864305678344;27872.303192420353;27951.301217469725;28417.573736394384;28594.285142871595;42916.356254655584;42937;42999.355009674255;43225.13549729051;43469.34795978126;322407;331962;333684;334180;336636;23034.308970730905;23253.534929300982;23303;23330.600163990213;23414.76585234194;40472.3929141069;41988.00683054723;42055;42565.787171063945;42716.572834272505;35565.28869422649;35751.46372804462;35786.28427431489;36250.27499450049;36521.269574608894;36516.634833651326;36820.26359472742;36912.630873692;36968.81515592513;37014.814925925195;34816;35992.820035899655;36929.63070369262;36944;38599.61400386073;29913.401731965674;33404;33435.33129337448;33765.155871103416;33863.83068084644;25473.745262547138;25761.098361558004;25855.411401514684;26145;26361.604575930993 02:45:18 INFO - PROCESS | 23459 | |2;jquery.html;361.10626200154616;363.82354558039356;366.98165091745403;384.43488072533364;384.849908535671;16337.918310408446;16556.751648725265;16924.4076457324;17290.049047302393;17299.91350043248;16018.279177437014;16314.510564683078;16944.83055169448;16965.32138714453;16972.745408818846;5115.488451154892;5217.973910130444;5251.028559716465;5264.263003179539;5269.99870024696;5100.795968161269;5135.35808023997;5206.869828254305;5221.765020574083;5241.580673546107;5021.84934451967;5102.056119617882;5142.794288228485;5180.818671346504;5194.532492075731;5055.595552355802;5079.619028572872;5105.974470127663;5109.3357863477695;5158.148905430599;4474.753888536129;4552.453705555321;4570.954290457119;4583.495815460296;4610.2854057621125;19918.402447926586;20052.298169563994;20306.69539956902;20688;20699.896500517552;1754.7017007108823;1781.9287228510843;1876.1744832273891;1898.8670793044491;1974.2695202774921;9244.583993720298;9284.164425201765;9335.113164249386;9364.063593640582;9482.241420686329;1737.1922056243782;1767.5227688524026;1799.8200179981898;1810.2396993262862;1834.3763120539081;52072.47927520752;68843.9999999995;70462;70600;74090;9600.567974441026;9641.469719165372;9872.111509964137;10124.73805009489;10162.644307449204;13786.310684465736;13816.447342106405;13837.86162138386;13896.58310250694;13896.722065558835;7244.203137654854;7313.853722925512;7427.85144297111;7508.812279693051;7611.200823913409;7134.393576545948;7271.309225623558;7339.596322202224;7469.365103966115;7478.3643390311345;4301.870943871689;4309.633681137076;4310.676699247506;4353.804078816461;4449.443819522559;1763.1184407796102;1778.9021603811914;1807.0783900210988;1839.2734869726382;1843.15215001101;833.795720048592;854.5599016506504;899.1772528136681;940.1961323068678;946.2004606107828;16310.347586096661;16440.342386304415;16716.24776885043;16740.6651866962;16877.156142193086;805.2591615713558;849.6941101203562;870.4951128345544;900.2797761790541;909.054583233443;9100.544972751335;9406.858897116548;9429.481378524248;9521.666741664147;9558.713238602713;388345;391935;395169;395418;401027;65877;71853;73416.32918354061;73422;80082;907.4283201582961;914.2685851318919;924.089771574998;941.1905761045496;941.3692825806726;14742.63143421423;14856.925715371353;14994.700105997601;15082.24588770535;15376.23118844031;35765.64234357623;35971.28057438889;36086.45870311895;36105.27789444144;36502.634973649925;47253.2912006327;50570.49429505658;50777.49222507876;51191.488085118675;51660;7304.853902922018;7595.734149304748;7634.8091297718;7711.190325015793;7859;11051.502682379152;11120.777584448104;11169.72075698114;11440.656780296604;11639;9771;10310.793784124426;10346.948265258625;10395.220358472994;10436.947815260875;10064.245181611263;10194.745131371776;10259.7435064124;10453.634122805664;10533.9473302633;10054;10420.635277765241;10479.895201047892;10525.210609204494;10559.788804224027;7115.5730656160795;7305.1233851938105;7367.484276100836;7565.363061643585;7895.960520197362;7797.064352277536;9046.683366082156;10545.9472702636;10548.525316360936;10560.788784224425 02:45:18 INFO - PROCESS | 23459 | |3;mootools.html;1379.9236595455545;1407.929603519824;1493.6788590453057;1691.4164613208438;1711.8459338659527;6643.833904152399;7268.200497945222;7519.060117485315;7771.6891324347025;7789.260020298069;7799.298063174313;7814.218578142183;7860.056793184825;7864.134945156043;7896.052473703164;2162.1891790578493;2187.223535644847;2197.5385169114506;2206.1616585697493;2208.580369729746;2164.5562659654734;2166.4042388343173;2201.1635578480236;2205;2211.237123192496;2141.582391433671;2173.3262688566597;2173.5544213436287;2178.3791619388476;2215.0253888289103;2120.650092734697;2127.946801329964;2136.2736669532355;2138.016512404296;2138.272987184357;2099.737532808399;2100.5798840232014;2105.210546045233;2121.406006318218;2133.1040962795664;7904.170062143449;7993.72021979228;8002.439829211958;8018.5990700464745;8021.5187088774865;4541.795619197144;4668.2064049111395;4694.08465349257;4753.928691069636;4760.595349395306;2891.8120322178993;2898.145047211057;2900.6374203224595;2942.6763056063814;2952.099609619065;906.9410488318305;938.4134915677702;949.1254771825658;949.7768024514234;952.4618590496348;10342.43116628585;10365.740856478573;10403.11573516252;10408.01123893229;10491.16070714341;3983.1237127831832;4145.316022856195;4171.49942006955;4226.640735537514;4252.510961239435;9013.504257265782;9066.909330906607;9093.727188184233;9111.134442227978;9116.8632470513;4687.296905464208;4696.7651617419;4701.529847015339;4725.763711814396;4733.810647574059;3701.1857391373856;4247.214265360918;4248.87253382399;4252.553481884358;4412.691111622155;3627.2745450909924;3703.203811180609;3746.119661879456;3756;3944.822482988215;1212.593781083347;1233.216907263876;1245.6574442028514;1246.8005119180887;1251.6245126462024;772.8686123359042;778.4122987144669;799.3605115907251;832.0888626953597;871.1941454154882;5255.159174532057;5285.339332583427;5291.656042357235;5493.807716729975;5658.7170641467765;869.6217145541709;871.5511511571545;893.3389291923929;900.8513595256841;901.7114523352465;3672.5225720656144;3678.6873115785456;3695.667389934919;3721.3115573618966;3733.3653278942643;9261.629534818667;9519.714408567754;9730.75673108178;9770.316077874622;9801.313908026512;9605.18355939753;9616.23070154386;9676.806463870824;9684.225261979025;9748.658796942073;7234.5659260444545;7349.7060117595765;7351.963240183765;7399.371053460516;7428.62856857155;5144.0997825381155;5249.432655173823;5268.868278293074;5281.973590132178;5411.78352865881;8718.564071796258;8806.383553151218;8816.779580510538;8840.911590884009;8886.289096872106;8823.338249631175;8831.63118169436;8974.910250897408;8980.146886045815;9046.50244236547;5556.194351819045;6010.519158467399;6193.535484838565;6372.840678982877;6487.448566871869;7290.817729556804;7304.525205861814;7340.669669864976;7346.77959661211;7366.416220512616;6407.327230640715;6591.670416479061;6610.2398224204835;6642.966785166043;6709.798706038827;6600.966995164993;6604.570702904296;6614.272430032596;6682;6709.094272273181;6070.3003159115515;6137.355577664281;6140.600860944024;6147.877042459215;6185.907211391923;4398.120375924764;4494;4553.089382123522;4577.267637178035;4596.770161491979;4514.68397212192;4537.09258148365;4574.382458368078;4581.541845815392;4591.380163677861 02:45:18 INFO - PROCESS | 23459 | |4;prototype.html;300.46667165780735;301.6591251885369;305.6286611766704;307.6246978686002;309.50942755732194;5098.515641014107;5115.872103197422;5116.948830511694;5135.871603209922;5156.871078223046;5001.724905130216;5003.774830132644;5021.38887778355;5031.4465408805;5043.722595257259;3722.4788529605876;3844.807759612022;3945;3964.583718709537;3996.3406038003695;3932.7640341579454;3932.7976333253328;3941.960580394202;3947.4868267125235;3963.009247688078;3906.2187562487475;3912.965258065804;3933.272344616255;3941.1723538057045;3950.940735888964;3818.8620823119695;3913.7064720146104;3956.8615098471705;3957.6240257175523;3960.5444624332954;3453.3611281912927;3458.8443520041405;3459.446488561843;3469.5663042119736;3473.496343030272;4875.829345972874;4879.780409881564;4887.657863949525;4892.339534162878;4897.559219670246;4415.646748260164;4455.643548516144;4519.254323036695;4527.320901864714;4540.7502587357685;5246.449122842085;5247.553957913582;5288.471152884719;5296.788128474856;5318.149096144598;3810.6760925321382;3814.9618503814886;3816.427535869642;3819.1216020315205;3824.426336049587;5391.272178255925;5541.89408024952;5542.418046105141;5544.279243698334;5555.2778138841695;3864.8840534784003;3872.9473379109118;3876.1472476055787;3885;3886.4170374443493;3937.409388591734;3950.229705207457;3954.307996100671;3960.1683646433994;3970.5433875104154;4481.843135490308;4482.641388688897;4484.304932735431;4493.550644935545;4494.775261236925;5165.767540460688;5219.5041471060185;5257.237700533401;5270.156774915995;5300.628955973045;1358.2190240611687;1373.921471644774;1374.10373684317;1380.3305396882504;1381.2955392749568;840.7682744778929;866.2593482572436;872.5724395046509;877.1886005445066;888.7955770172896;4504.549545045469;4570.337301091323;4620.653450991122;4647.34937108805;4652.464966528893;5453.89128196924;5481.698506582096;5512.924979628934;5525.546533416615;5531.3915469298345;4418.756968366706;4670.556297151765;4686.109639168547;4697.553732395417;4715.575598196178;2887.6246088008425;2901.63623097144;2907.418516296707;2942.161483977099;2947.3810499794854;5091.465396133427;5137.563307118862;5154.664946778447;5161;5192.766325515361;5438.728063596884;5492.5605951523785;5524.867402182543;5543.417941116206;5591.832245032656;5056.002878862829;5066.189409694432;5086.567641750418;5086.771095300646;5109.948900511022;5441.918371224514;5450.874159077884;5451.64564303319;5474.890502190014;5491.780328786804;5069;5321.920171197357;5365.356157261153;5411.404745477916;5419.918701219406;5112.642115052059;5121.871953201051;5175.14610089331;5208.255234496486;5211.557017653542;3790.8673196437994;3821.694264458892;3824.9617503824607;3834.482344883405;3835.8273877675015;5217.34783152106;5439.537639300704;5481.588880833874;5502.8349149525575;5555.611107222456;5303.992241474108;5327.866803329948;5330.546903513245;5346.518813306821;5353.411124776349;5167.173252279617;5320.856015956588;5333.093374126331;5375.758090885998;5375.81184658535;5221.947780522298;5243.5542978847225;5253.947460525345;5258.1849813279005;5281.808049659348;5089.3638295213095;5199.792008319776;5272.420033796203;5290.65610735301;5300.098983172947;5210.244514545446;5227.18978558324;5229.973850130725;5238.135707608202;5238.4237733850005 02:45:18 INFO - PROCESS | 23459 | |5;yui.html;621.2265729167186;643.4833634189158;666.623357802841;730.6711979609178;747.1669088965803;12027.819582706266;13275.13711608746;13532.391042403091;13565.389557469913;13596.864031359684;12968.481260749559;13142.802857957115;13143.868561314384;13170.27563484008;13226;614.3273115938041;736.4476642518111;749.3368368993425;767.869462191426;770.603139383218;761.0220866186951;764.2128607534221;766.5017738469984;767.6583920155533;767.9193684663114;804.5574933786394;806.1696452653777;806.3549160671469;807.1645846548823;809.1261437647327;799.5083023940235;801.1587832775591;802.2779498451412;804.7103042904549;805.5730462854697;584.0567483514094;584.7777844419094;585.4906231578553;588.0825911577953;588.4703766610043;13153.079284450092;13190.340482975813;13236.536721214712;13236.801447978289;13256.138351007154;13291.202527848263;13374.465021399132;13467.124636898669;13504.864951350459;13548.593542193652;9598;9916.454594997344;10078.647247346307;10179.84730229047;10235.79528409435;3277.2953814929906;3297.258116923697;3327.8336083195986;3334.683205095512;3396.2018925552475;59711.402885971016;59737.70131149316;59810.70094649499;60841.39158608446;60946;10153.441560714231;10282.897171028193;10387;10437.425941573287;10500.422476763699;18751.34370297033;19023.524411889535;19110.331138410365;19112.61774764497;19112.904435478013;7080.221175670672;7133.357997780225;7151.642417879085;7185.56886586796;7238.6018768968215;3671.8714844980295;3752.4934133891575;3762.5673047599876;3782.7541209821825;3831.1762970961377;2755.3662657588866;2840.1905456944673;2842.1189431275957;2852.700466451034;2853.22962800047;556.6131538580647;575.6517307029271;578.4880380862967;583.8102616649521;589.2957915291272;564.3989151553583;566.6996491859321;581.0586849304154;593.8307582339013;602.9246344206974;8118.512889226666;8436.198561136682;8528.147185281547;8575.056743758181;8620.396572240008;525.8606469285643;602.8854517641633;606.8634557224589;628.2368612014003;629.5026928726255;3705.5182826232417;3779.5842457329672;3782.08371779225;3819.1216020315483;4216.746995180238;59935.400645993854;61148.082778758355;75839.62080189564;78378;80005.19994800094;78394.6080269595;81646.59176704197;82483.58758206171;83437.58281208554;84908;52735;66861.66569167122;74550;74605;75657.24342756612;8152.385128199942;8692.869606955774;8766.34252431083;8802;8887.377883548348;44564.55435445734;45895;46074;46675.29987050265;46760.53239467698;57160;57703.711481442326;65391.67304163449;65525;66566;11742.530298788295;11885.702857428634;12000.75998480043;12170.634880953585;12340.876591233973;12603.432845521791;12717.93641031826;12856.035797315426;13272.203667779964;13973.231472269123;11669.88330116688;11912.821307680219;12474.18917770342;12930.806037909251;13042.54351097707;11351.599816135835;11595.478203481032;12101.152919295564;12486.625401237614;12672;11445.885541144482;11815.645530634094;12296.631101066982;12329.938350308192;12611.558595449114;9596.712098637052;9940.45327506994;10053.949730251303;10063.547140378847;10108.646197383056;10220.642277520252;10575.788484230427;10582.922987978696;10695.251332406657;10741.731456713645 02:45:18 INFO - PROCESS | 23459 | __end_tp_report 02:45:18 INFO - PROCESS | 23459 | __start_cc_report 02:45:18 INFO - PROCESS | 23459 | _x_x_mozilla_cycle_collect,390 02:45:18 INFO - PROCESS | 23459 | __end_cc_report 02:45:18 INFO - PROCESS | 23459 | __startTimestamp1468921518923__endTimestamp 02:45:18 INFO - PROCESS | 23459 | 02:45:18 INFO - PROCESS | 23459 | ------- Summary: start ------- 02:45:18 INFO - PROCESS | 23459 | Number of tests: 6 02:45:18 INFO - PROCESS | 23459 | 02:45:18 INFO - PROCESS | 23459 | [#0] dojo.html Cycles:165 Average:4765.67 Median:4890.95 stddev:611.49 (12.5%) stddev-sans-first:590.22 02:45:18 INFO - PROCESS | 23459 | Values: 2641.4 2681.5 2690.8 2716.9 2717.3 4795.0 4801.0 4870.3 4877.4 4894.2 4735.3 4807.4 4812.1 4854.1 4861.9 4398.3 4424.1 4581.6 4582.5 4582.7 410.3 4254.7 4386.3 4389.1 4496.0 4388.4 4437.3 4458.0 4474.3 4512.0 4427.6 4465.0 4466.5 4467.7 4500.1 4313.5 4362.2 4380.7 4401.7 4405.9 4749.7 4791.5 4792.4 4793.1 4810.9 4922.6 5067.8 5250.9 5251.0 5254.1 5085.5 5108.7 5111.1 5111.8 5175.7 4838.1 4845.5 4848.2 4851.7 4904.1 5279.0 5295.6 5332.8 5358.5 5381.0 5158.6 5172.3 5180.2 5182.6 5186.8 5278.6 5280.4 5280.7 5281.1 5303.5 4999.1 5005.5 5033.5 5067.5 5095.3 5010.0 5046.9 5070.5 5085.7 5108.4 4358.7 4362.8 4376.5 4384.8 4413.6 3780.0 3826.8 3836.4 3894.3 3894.9 4516.6 4518.1 4518.3 4563.1 4603.3 5274.0 5281.7 5285.8 5298.7 5314.5 4393.6 4452.0 4495.0 4512.8 4518.1 4663.0 4677.4 4708.8 4719.2 4760.2 4787.9 4856.0 4866.3 4888.7 4915.5 5147.9 5209.0 5217.0 5247.0 5292.4 4880.2 4887.2 4891.0 4892.4 4948.4 4906.6 5116.3 5129.0 5139.3 5158.7 5068.4 5145.4 5155.3 5173.0 5181.8 5049.3 5051.0 5074.8 5109.2 5118.9 4913.2 5034.1 5053.7 5056.9 5071.2 4990.4 5022.6 5025.6 5066.5 5112.4 5160.2 5181.6 5188.5 5205.2 5219.8 4759.5 4827.5 4863.9 5055.2 5059.7 02:45:18 INFO - PROCESS | 23459 | 02:45:18 INFO - PROCESS | 23459 | [#1] ext.html Cycles:180 Average:45712.82 Median:36121.55 stddev:85839.05 (237.6%) stddev-sans-first:86012.89 02:45:18 INFO - PROCESS | 23459 | Values: 555.5 572.3 577.2 578.7 584.4 26697.5 38940.6 40300.4 40488.6 44485.1 41232.8 41383.6 41547.6 41605.6 41752.6 7746.5 7839.3 7894.5 7905.6 7918.4 7804.9 7935.4 7940.1 7947.8 7960.5 7886.5 7906.8 7915.1 7968.5 7971.8 7894.4 7903.7 7911.1 7915.0 7962.4 7803.5 7838.4 7841.0 7845.3 7855.7 38393.0 38871.2 38965.2 39093.2 39264.0 3127.7 3261.6 3398.3 3501.7 3757.0 28286.4 28673.7 28735.9 28970.1 29805.1 3080.7 3093.8 3195.9 3228.9 3232.1 250135.0 250677.0 252117.0 252457.0 252639.0 31347.8 32496.0 32557.7 51266.5 52155.7 33422.5 33513.3 33525.3 33542.2 33563.5 13671.5 13783.8 13802.7 13822.5 13853.9 11397.4 11521.1 11530.7 11533.7 11565.8 7837.1 7837.3 7851.5 7887.9 7913.1 3084.5 3100.5 3121.3 3123.8 3167.3 809.8 902.5 946.6 948.2 954.7 27724.0 27818.9 27981.6 28572.4 28590.0 960.2 967.4 998.8 1016.3 1018.2 14668.6 14861.3 15114.5 15244.6 15320.5 120783.0 416907.0 417308.0 417665.0 418014.0 48057.5 49628.3 49649.0 49780.0 49819.8 1187.1 1196.3 1206.0 1207.4 1213.8 27138.9 27872.3 27951.3 28417.6 28594.3 42916.4 42937.0 42999.4 43225.1 43469.3 322407.0 331962.0 333684.0 334180.0 336636.0 23034.3 23253.5 23303.0 23330.6 23414.8 40472.4 41988.0 42055.0 42565.8 42716.6 35565.3 35751.5 35786.3 36250.3 36521.3 36516.6 36820.3 36912.6 36968.8 37014.8 34816.0 35992.8 36929.6 36944.0 38599.6 29913.4 33404.0 33435.3 33765.2 33863.8 25473.7 25761.1 25855.4 26145.0 26361.6 02:45:18 INFO - PROCESS | 23459 | 02:45:18 INFO - PROCESS | 23459 | [#2] jquery.html Cycles:180 Average:24130.15 Median:4561.70 stddev:64989.91 (1424.7%) stddev-sans-first:65147.72 02:45:18 INFO - PROCESS | 23459 | Values: 361.1 363.8 367.0 384.4 384.8 16337.9 16556.8 16924.4 17290.0 17299.9 16018.3 16314.5 16944.8 16965.3 16972.7 5115.5 5218.0 5251.0 5264.3 5270.0 5100.8 5135.4 5206.9 5221.8 5241.6 5021.8 5102.1 5142.8 5180.8 5194.5 5055.6 5079.6 5106.0 5109.3 5158.1 4474.8 4552.5 4571.0 4583.5 4610.3 19918.4 20052.3 20306.7 20688.0 20699.9 1754.7 1781.9 1876.2 1898.9 1974.3 9244.6 9284.2 9335.1 9364.1 9482.2 1737.2 1767.5 1799.8 1810.2 1834.4 52072.5 68844.0 70462.0 70600.0 74090.0 9600.6 9641.5 9872.1 10124.7 10162.6 13786.3 13816.4 13837.9 13896.6 13896.7 7244.2 7313.9 7427.9 7508.8 7611.2 7134.4 7271.3 7339.6 7469.4 7478.4 4301.9 4309.6 4310.7 4353.8 4449.4 1763.1 1778.9 1807.1 1839.3 1843.2 833.8 854.6 899.2 940.2 946.2 16310.3 16440.3 16716.2 16740.7 16877.2 805.3 849.7 870.5 900.3 909.1 9100.5 9406.9 9429.5 9521.7 9558.7 388345.0 391935.0 395169.0 395418.0 401027.0 65877.0 71853.0 73416.3 73422.0 80082.0 907.4 914.3 924.1 941.2 941.4 14742.6 14856.9 14994.7 15082.2 15376.2 35765.6 35971.3 36086.5 36105.3 36502.6 47253.3 50570.5 50777.5 51191.5 51660.0 7304.9 7595.7 7634.8 7711.2 7859.0 11051.5 11120.8 11169.7 11440.7 11639.0 9771.0 10310.8 10346.9 10395.2 10436.9 10064.2 10194.7 10259.7 10453.6 10533.9 10054.0 10420.6 10479.9 10525.2 10559.8 7115.6 7305.1 7367.5 7565.4 7896.0 7797.1 9046.7 10545.9 10548.5 10560.8 02:45:18 INFO - PROCESS | 23459 | 02:45:18 INFO - PROCESS | 23459 | [#3] mootools.html Cycles:180 Average:5110.62 Median:5288.50 stddev:2835.12 (53.6%) stddev-sans-first:2829.21 02:45:18 INFO - PROCESS | 23459 | Values: 1379.9 1407.9 1493.7 1691.4 1711.8 6643.8 7268.2 7519.1 7771.7 7789.3 7799.3 7814.2 7860.1 7864.1 7896.1 2162.2 2187.2 2197.5 2206.2 2208.6 2164.6 2166.4 2201.2 2205.0 2211.2 2141.6 2173.3 2173.6 2178.4 2215.0 2120.7 2127.9 2136.3 2138.0 2138.3 2099.7 2100.6 2105.2 2121.4 2133.1 7904.2 7993.7 8002.4 8018.6 8021.5 4541.8 4668.2 4694.1 4753.9 4760.6 2891.8 2898.1 2900.6 2942.7 2952.1 906.9 938.4 949.1 949.8 952.5 10342.4 10365.7 10403.1 10408.0 10491.2 3983.1 4145.3 4171.5 4226.6 4252.5 9013.5 9066.9 9093.7 9111.1 9116.9 4687.3 4696.8 4701.5 4725.8 4733.8 3701.2 4247.2 4248.9 4252.6 4412.7 3627.3 3703.2 3746.1 3756.0 3944.8 1212.6 1233.2 1245.7 1246.8 1251.6 772.9 778.4 799.4 832.1 871.2 5255.2 5285.3 5291.7 5493.8 5658.7 869.6 871.6 893.3 900.9 901.7 3672.5 3678.7 3695.7 3721.3 3733.4 9261.6 9519.7 9730.8 9770.3 9801.3 9605.2 9616.2 9676.8 9684.2 9748.7 7234.6 7349.7 7352.0 7399.4 7428.6 5144.1 5249.4 5268.9 5282.0 5411.8 8718.6 8806.4 8816.8 8840.9 8886.3 8823.3 8831.6 8974.9 8980.1 9046.5 5556.2 6010.5 6193.5 6372.8 6487.4 7290.8 7304.5 7340.7 7346.8 7366.4 6407.3 6591.7 6610.2 6643.0 6709.8 6601.0 6604.6 6614.3 6682.0 6709.1 6070.3 6137.4 6140.6 6147.9 6185.9 4398.1 4494.0 4553.1 4577.3 4596.8 4514.7 4537.1 4574.4 4581.5 4591.4 02:45:18 INFO - PROCESS | 23459 | 02:45:18 INFO - PROCESS | 23459 | [#4] prototype.html Cycles:180 Average:4398.97 Median:5061.10 stddev:1278.75 (25.3%) stddev-sans-first:1244.78 02:45:18 INFO - PROCESS | 23459 | Values: 300.5 301.7 305.6 307.6 309.5 5098.5 5115.9 5116.9 5135.9 5156.9 5001.7 5003.8 5021.4 5031.4 5043.7 3722.5 3844.8 3945.0 3964.6 3996.3 3932.8 3932.8 3942.0 3947.5 3963.0 3906.2 3913.0 3933.3 3941.2 3950.9 3818.9 3913.7 3956.9 3957.6 3960.5 3453.4 3458.8 3459.4 3469.6 3473.5 4875.8 4879.8 4887.7 4892.3 4897.6 4415.6 4455.6 4519.3 4527.3 4540.8 5246.4 5247.6 5288.5 5296.8 5318.1 3810.7 3815.0 3816.4 3819.1 3824.4 5391.3 5541.9 5542.4 5544.3 5555.3 3864.9 3872.9 3876.1 3885.0 3886.4 3937.4 3950.2 3954.3 3960.2 3970.5 4481.8 4482.6 4484.3 4493.6 4494.8 5165.8 5219.5 5257.2 5270.2 5300.6 1358.2 1373.9 1374.1 1380.3 1381.3 840.8 866.3 872.6 877.2 888.8 4504.5 4570.3 4620.7 4647.3 4652.5 5453.9 5481.7 5512.9 5525.5 5531.4 4418.8 4670.6 4686.1 4697.6 4715.6 2887.6 2901.6 2907.4 2942.2 2947.4 5091.5 5137.6 5154.7 5161.0 5192.8 5438.7 5492.6 5524.9 5543.4 5591.8 5056.0 5066.2 5086.6 5086.8 5109.9 5441.9 5450.9 5451.6 5474.9 5491.8 5069.0 5321.9 5365.4 5411.4 5419.9 5112.6 5121.9 5175.1 5208.3 5211.6 3790.9 3821.7 3825.0 3834.5 3835.8 5217.3 5439.5 5481.6 5502.8 5555.6 5304.0 5327.9 5330.5 5346.5 5353.4 5167.2 5320.9 5333.1 5375.8 5375.8 5221.9 5243.6 5253.9 5258.2 5281.8 5089.4 5199.8 5272.4 5290.7 5300.1 5210.2 5227.2 5230.0 5238.1 5238.4 02:45:18 INFO - PROCESS | 23459 | 02:45:18 INFO - PROCESS | 23459 | [#5] yui.html Cycles:180 Average:16930.58 Median:23643.20 stddev:22756.22 (96.2%) stddev-sans-first:22787.10 02:45:18 INFO - PROCESS | 23459 | Values: 621.2 643.5 666.6 730.7 747.2 12027.8 13275.1 13532.4 13565.4 13596.9 12968.5 13142.8 13143.9 13170.3 13226.0 614.3 736.4 749.3 767.9 770.6 761.0 764.2 766.5 767.7 767.9 804.6 806.2 806.4 807.2 809.1 799.5 801.2 802.3 804.7 805.6 584.1 584.8 585.5 588.1 588.5 13153.1 13190.3 13236.5 13236.8 13256.1 13291.2 13374.5 13467.1 13504.9 13548.6 9598.0 9916.5 10078.6 10179.8 10235.8 3277.3 3297.3 3327.8 3334.7 3396.2 59711.4 59737.7 59810.7 60841.4 60946.0 10153.4 10282.9 10387.0 10437.4 10500.4 18751.3 19023.5 19110.3 19112.6 19112.9 7080.2 7133.4 7151.6 7185.6 7238.6 3671.9 3752.5 3762.6 3782.8 3831.2 2755.4 2840.2 2842.1 2852.7 2853.2 556.6 575.7 578.5 583.8 589.3 564.4 566.7 581.1 593.8 602.9 8118.5 8436.2 8528.1 8575.1 8620.4 525.9 602.9 606.9 628.2 629.5 3705.5 3779.6 3782.1 3819.1 4216.7 59935.4 61148.1 75839.6 78378.0 80005.2 78394.6 81646.6 82483.6 83437.6 84908.0 52735.0 66861.7 74550.0 74605.0 75657.2 8152.4 8692.9 8766.3 8802.0 8887.4 44564.6 45895.0 46074.0 46675.3 46760.5 57160.0 57703.7 65391.7 65525.0 66566.0 11742.5 11885.7 12000.8 12170.6 12340.9 12603.4 12717.9 12856.0 13272.2 13973.2 11669.9 11912.8 12474.2 12930.8 13042.5 11351.6 11595.5 12101.2 12486.6 12672.0 11445.9 11815.6 12296.6 12329.9 12611.6 9596.7 9940.5 10053.9 10063.5 10108.6 10220.6 10575.8 10582.9 10695.3 10741.7 02:45:18 INFO - PROCESS | 23459 | -------- Summary: end -------- 02:45:18 INFO - PROCESS | 23459 | 02:45:19 INFO - TEST-INFO | 23459: exit 0 02:45:19 INFO - TEST-OK | dromaeo_css | took 1116186ms 02:45:19 INFO - TEST-START | kraken 02:45:19 INFO - operating with platform_type : linux_ 02:45:19 INFO - Initialising browser for kraken test... 02:45:19 INFO - TEST-INFO | started process 23705 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg0JAyI/profile http://localhost:49118/getInfo.html) 02:45:24 INFO - PROCESS | 23705 | __metrics Screen width/height:1600/1200 02:45:24 INFO - PROCESS | 23705 | colorDepth:24 02:45:24 INFO - PROCESS | 23705 | Browser inner width/height: 1024/697 02:45:24 INFO - PROCESS | 23705 | __metrics 02:45:24 ERROR - PROCESS | 23705 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 02:45:25 INFO - TEST-INFO | 23705: exit 0 02:45:25 INFO - Browser initialized. 02:45:25 INFO - Running cycle 1/1 for kraken test... 02:45:25 INFO - TEST-INFO | started process 23826 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg0JAyI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:45:37 INFO - PROCESS | 23826 | RSS: Main: 169439232 02:45:37 INFO - PROCESS | 23826 | 02:45:39 INFO - PROCESS | 23826 | Cycle 1(1): loaded http://localhost:49118/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49118/tests/kraken/driver.html?testName=audio-beat-detection) 02:45:40 INFO - PROCESS | 23826 | RSS: Main: 173998080 02:45:40 INFO - PROCESS | 23826 | 02:45:43 INFO - PROCESS | 23826 | Cycle 1(1): loaded http://localhost:49118/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49118/tests/kraken/driver.html?testName=audio-dft) 02:45:44 INFO - PROCESS | 23826 | RSS: Main: 173797376 02:45:44 INFO - PROCESS | 23826 | 02:45:47 INFO - PROCESS | 23826 | Cycle 1(1): loaded http://localhost:49118/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49118/tests/kraken/driver.html?testName=audio-fft) 02:45:47 INFO - PROCESS | 23826 | RSS: Main: 168718336 02:45:47 INFO - PROCESS | 23826 | 02:45:50 INFO - PROCESS | 23826 | Cycle 1(1): loaded http://localhost:49118/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49118/tests/kraken/driver.html?testName=audio-oscillator) 02:45:50 INFO - PROCESS | 23826 | RSS: Main: 169488384 02:45:50 INFO - PROCESS | 23826 | 02:45:52 INFO - PROCESS | 23826 | Cycle 1(1): loaded http://localhost:49118/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49118/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:45:53 INFO - PROCESS | 23826 | RSS: Main: 169492480 02:45:53 INFO - PROCESS | 23826 | 02:45:56 INFO - PROCESS | 23826 | Cycle 1(1): loaded http://localhost:49118/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49118/tests/kraken/driver.html?testName=imaging-darkroom) 02:45:57 INFO - PROCESS | 23826 | RSS: Main: 169431040 02:45:57 INFO - PROCESS | 23826 | 02:46:00 INFO - PROCESS | 23826 | Cycle 1(1): loaded http://localhost:49118/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49118/tests/kraken/driver.html?testName=imaging-desaturate) 02:46:01 INFO - PROCESS | 23826 | RSS: Main: 167538688 02:46:01 INFO - PROCESS | 23826 | 02:46:04 INFO - PROCESS | 23826 | Cycle 1(1): loaded http://localhost:49118/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49118/tests/kraken/driver.html?testName=json-parse-financial) 02:46:05 INFO - PROCESS | 23826 | RSS: Main: 169259008 02:46:05 INFO - PROCESS | 23826 | 02:46:06 INFO - PROCESS | 23826 | Cycle 1(1): loaded http://localhost:49118/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49118/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:46:07 INFO - PROCESS | 23826 | RSS: Main: 169488384 02:46:07 INFO - PROCESS | 23826 | 02:46:09 INFO - PROCESS | 23826 | Cycle 1(1): loaded http://localhost:49118/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49118/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:46:10 INFO - PROCESS | 23826 | RSS: Main: 169197568 02:46:10 INFO - PROCESS | 23826 | 02:46:12 INFO - PROCESS | 23826 | Cycle 1(1): loaded http://localhost:49118/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49118/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:46:13 INFO - PROCESS | 23826 | RSS: Main: 169660416 02:46:13 INFO - PROCESS | 23826 | 02:46:15 INFO - PROCESS | 23826 | Cycle 1(1): loaded http://localhost:49118/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49118/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:46:16 INFO - PROCESS | 23826 | RSS: Main: 170061824 02:46:16 INFO - PROCESS | 23826 | 02:46:19 INFO - PROCESS | 23826 | Cycle 1(1): loaded http://localhost:49118/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49118/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:46:19 INFO - PROCESS | 23826 | RSS: Main: 169521152 02:46:19 INFO - PROCESS | 23826 | 02:46:21 INFO - PROCESS | 23826 | Cycle 1(1): loaded http://localhost:49118/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49118/tests/kraken/driver.html?testName=ai-astar) 02:46:21 INFO - PROCESS | 23826 | RSS: Main: 170442752 02:46:21 INFO - PROCESS | 23826 | 02:46:21 INFO - PROCESS | 23826 | __start_tp_report 02:46:21 INFO - PROCESS | 23826 | _x_x_mozilla_page_load 02:46:21 INFO - PROCESS | 23826 | _x_x_mozilla_page_load_details 02:46:21 INFO - PROCESS | 23826 | |i|pagename|runs| 02:46:21 INFO - PROCESS | 23826 | |0;ai-astar;105;116;110;116;115;115;116;116;116;113 02:46:21 INFO - PROCESS | 23826 | |1;audio-beat-detection;150;128;153;177;124;163;149;125;176;123 02:46:21 INFO - PROCESS | 23826 | |2;audio-dft;164;163;163;165;192;164;163;163;163;165 02:46:21 INFO - PROCESS | 23826 | |3;audio-fft;76;78;76;161;77;77;76;77;166;78 02:46:21 INFO - PROCESS | 23826 | |4;audio-oscillator;85;86;149;86;86;85;132;86;86;146 02:46:21 INFO - PROCESS | 23826 | |5;imaging-gaussian-blur;117;117;117;117;118;117;118;117;117;118 02:46:21 INFO - PROCESS | 23826 | |6;imaging-darkroom;149;149;150;148;148;148;148;149;148;149 02:46:21 INFO - PROCESS | 23826 | |7;imaging-desaturate;96;97;96;95;97;96;96;96;96;96 02:46:21 INFO - PROCESS | 23826 | |8;json-parse-financial;65;64;63;65;72;63;62;64;63;70 02:46:21 INFO - PROCESS | 23826 | |9;json-stringify-tinderbox;68;68;67;69;68;67;68;68;70;68 02:46:21 INFO - PROCESS | 23826 | |10;stanford-crypto-aes;82;80;80;86;80;79;79;79;83;90 02:46:21 INFO - PROCESS | 23826 | |11;stanford-crypto-ccm;143;144;135;140;137;131;142;131;166;141 02:46:21 INFO - PROCESS | 23826 | |12;stanford-crypto-pbkdf2;169;172;165;168;172;165;168;166;166;167 02:46:21 INFO - PROCESS | 23826 | |13;stanford-crypto-sha256-iterative;69;68;67;67;67;67;67;71;66;69 02:46:21 INFO - PROCESS | 23826 | __end_tp_report 02:46:21 INFO - PROCESS | 23826 | __start_cc_report 02:46:21 INFO - PROCESS | 23826 | _x_x_mozilla_cycle_collect,995 02:46:21 INFO - PROCESS | 23826 | __end_cc_report 02:46:21 INFO - PROCESS | 23826 | __startTimestamp1468921581976__endTimestamp 02:46:21 INFO - PROCESS | 23826 | 02:46:21 INFO - PROCESS | 23826 | ------- Summary: start ------- 02:46:21 INFO - PROCESS | 23826 | Number of tests: 14 02:46:21 INFO - PROCESS | 23826 | 02:46:21 INFO - PROCESS | 23826 | [#0] ai-astar Cycles:10 Average:113.80 Median:116.00 stddev:3.65 (3.1%) stddev-sans-first:2.05 02:46:21 INFO - PROCESS | 23826 | Values: 105.0 116.0 110.0 116.0 115.0 115.0 116.0 116.0 116.0 113.0 02:46:21 INFO - PROCESS | 23826 | 02:46:21 INFO - PROCESS | 23826 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:151.50 stddev:21.07 (13.9%) stddev-sans-first:22.32 02:46:21 INFO - PROCESS | 23826 | Values: 150.0 128.0 153.0 177.0 124.0 163.0 149.0 125.0 176.0 123.0 02:46:21 INFO - PROCESS | 23826 | 02:46:21 INFO - PROCESS | 23826 | [#2] audio-dft Cycles:10 Average:166.50 Median:164.00 stddev:9.00 (5.5%) stddev-sans-first:9.50 02:46:21 INFO - PROCESS | 23826 | Values: 164.0 163.0 163.0 165.0 192.0 164.0 163.0 163.0 163.0 165.0 02:46:21 INFO - PROCESS | 23826 | 02:46:21 INFO - PROCESS | 23826 | [#3] audio-fft Cycles:10 Average:94.20 Median:77.00 stddev:36.55 (47.5%) stddev-sans-first:38.17 02:46:21 INFO - PROCESS | 23826 | Values: 76.0 78.0 76.0 161.0 77.0 77.0 76.0 77.0 166.0 78.0 02:46:21 INFO - PROCESS | 23826 | 02:46:21 INFO - PROCESS | 23826 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:86.00 stddev:27.68 (32.2%) stddev-sans-first:28.61 02:46:21 INFO - PROCESS | 23826 | Values: 85.0 86.0 149.0 86.0 86.0 85.0 132.0 86.0 86.0 146.0 02:46:21 INFO - PROCESS | 23826 | 02:46:21 INFO - PROCESS | 23826 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 02:46:21 INFO - PROCESS | 23826 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 118.0 117.0 117.0 118.0 02:46:21 INFO - PROCESS | 23826 | 02:46:21 INFO - PROCESS | 23826 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 02:46:21 INFO - PROCESS | 23826 | Values: 149.0 149.0 150.0 148.0 148.0 148.0 148.0 149.0 148.0 149.0 02:46:21 INFO - PROCESS | 23826 | 02:46:21 INFO - PROCESS | 23826 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 02:46:21 INFO - PROCESS | 23826 | Values: 96.0 97.0 96.0 95.0 97.0 96.0 96.0 96.0 96.0 96.0 02:46:21 INFO - PROCESS | 23826 | 02:46:21 INFO - PROCESS | 23826 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:64.50 stddev:3.28 (5.1%) stddev-sans-first:3.48 02:46:21 INFO - PROCESS | 23826 | Values: 65.0 64.0 63.0 65.0 72.0 63.0 62.0 64.0 63.0 70.0 02:46:21 INFO - PROCESS | 23826 | 02:46:21 INFO - PROCESS | 23826 | [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 02:46:21 INFO - PROCESS | 23826 | Values: 68.0 68.0 67.0 69.0 68.0 67.0 68.0 68.0 70.0 68.0 02:46:21 INFO - PROCESS | 23826 | 02:46:21 INFO - PROCESS | 23826 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:81.00 stddev:3.65 (4.5%) stddev-sans-first:3.87 02:46:21 INFO - PROCESS | 23826 | Values: 82.0 80.0 80.0 86.0 80.0 79.0 79.0 79.0 83.0 90.0 02:46:21 INFO - PROCESS | 23826 | 02:46:21 INFO - PROCESS | 23826 | [#11] stanford-crypto-ccm Cycles:10 Average:141.00 Median:141.50 stddev:9.96 (7.0%) stddev-sans-first:10.53 02:46:21 INFO - PROCESS | 23826 | Values: 143.0 144.0 135.0 140.0 137.0 131.0 142.0 131.0 166.0 141.0 02:46:21 INFO - PROCESS | 23826 | 02:46:21 INFO - PROCESS | 23826 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:168.00 stddev:2.57 (1.5%) stddev-sans-first:2.69 02:46:21 INFO - PROCESS | 23826 | Values: 169.0 172.0 165.0 168.0 172.0 165.0 168.0 166.0 166.0 167.0 02:46:21 INFO - PROCESS | 23826 | 02:46:21 INFO - PROCESS | 23826 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.50 stddev:1.48 (2.2%) stddev-sans-first:1.50 02:46:21 INFO - PROCESS | 23826 | Values: 69.0 68.0 67.0 67.0 67.0 67.0 67.0 71.0 66.0 69.0 02:46:21 INFO - PROCESS | 23826 | -------- Summary: end -------- 02:46:21 INFO - PROCESS | 23826 | 02:46:22 INFO - TEST-INFO | 23826: exit 0 02:46:23 INFO - TEST-OK | kraken | took 63315ms 02:46:23 INFO - SUITE-END | took 1179s 02:46:23 INFO - Completed test suite (00:19:39) 02:46:23 INFO - javascript benchmark 02:46:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6391.507274908606, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2641.432092100198, 2681.5441374966254, 2690.838549687018, 2716.8505732184735, 2717.320669832542, 4794.976025119874, 4800.975995120024, 4870.293807397929, 4877.414710234777, 4894.192458244385, 4735.3133795599615, 4807.447143578481, 4812.109759694459, 4854.101991131643, 4861.878453038676, 4398.252297109491, 4424.137293227822, 4581.564751348633, 4582.450105987286, 4582.702124361923, 410.3409516672911, 4254.744715317075, 4386.298192289234, 4389.056352884129, 4496.0, 4388.363687265361, 4437.312216606431, 4458.041521072985, 4474.328850672393, 4512.029913568598, 4427.623651989585, 4464.950736576902, 4466.508684044752, 4467.687261891669, 4500.077484115748, 4313.460817397825, 4362.192994296033, 4380.715253508543, 4401.735895846259, 4405.911881762347, 4749.691270067435, 4791.496892826272, 4792.448868380111, 4793.065352256312, 4810.879728006793, 4922.581580565657, 5067.822626208065, 5250.9474905250845, 5250.97374513125, 5254.106801843657, 5085.542301192873, 5108.667936584147, 5111.05445492585, 5111.846644600668, 5175.663581867167, 4838.080764654705, 4845.466998630148, 4848.248521479177, 4851.708897466164, 4904.068227036852, 5279.049771041249, 5295.628537941651, 5332.813351532678, 5358.517733404013, 5380.950714610613, 5158.6131040171385, 5172.27588137661, 5180.171172612364, 5182.6113041521285, 5186.792528298825, 5278.577713782888, 5280.419153893145, 5280.709560974184, 5281.102212623787, 5303.522682958553, 4999.100161970808, 5005.524475174852, 5033.496650334937, 5067.4932506749765, 5095.31213286209, 5010.023045506165, 5046.949530504721, 5070.467600901926, 5085.694858308513, 5108.412532558803, 4358.694891357574, 4362.760048197316, 4376.540463251313, 4384.758838263926, 4413.646908247332, 3780.0, 3826.8086595670106, 3836.405357169643, 3894.337962546374, 3894.9221015580097, 4516.593506584423, 4518.1415531049, 4518.254488009507, 4563.0873825235085, 4603.309503574491, 5273.971575542809, 5281.735913204325, 5285.762140703678, 5298.735063246822, 5314.4951229633125, 4393.648508119343, 4452.0, 4494.977525112354, 4512.796924138356, 4518.051209246095, 4662.953370466252, 4677.4387073550715, 4708.835190768306, 4719.244920812654, 4760.190767569452, 4787.904241915212, 4855.95144048555, 4866.29438731389, 4888.6577939543895, 4915.48387419323, 5147.948520514897, 5209.0, 5216.9739151304, 5246.97376513115, 5292.391374991926, 4880.170371036861, 4887.242477416006, 4890.951090489192, 4892.3884514435695, 4948.38145231846, 4906.582940450102, 5116.258142569232, 5129.0, 5139.280500729826, 5158.742062896915, 5068.366454193226, 5145.3568303962, 5155.304033955368, 5173.042987047408, 5181.766820493011, 5049.343585333883, 5050.974745126251, 5074.847754567369, 5109.182530795055, 5118.872028199325, 4913.213885778258, 5034.0686972910125, 5053.7220452875445, 5056.873578160428, 5071.18860982241, 4990.4011518618, 5022.598192144546, 5025.623078269071, 5066.518680725325, 5112.437631860418, 5160.200168973815, 5181.611379146504, 5188.481151884781, 5205.219217117463, 5219.76511057011, 4759.547842955052, 4827.468978412442, 4863.902721945612, 5055.241713742968, 5059.671121377099], "value": 4728.160176284549, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.5083750880472, 572.3160822816734, 577.2121054760248, 578.667266321865, 584.4301805739403, 26697.466050679, 38940.61059389405, 40300.39549406761, 40488.595114048854, 44485.110297794025, 41232.793836030774, 41383.58616413835, 41547.58452415475, 41605.58394416055, 41752.58247417525, 7746.535207887545, 7839.294463498284, 7894.526328420285, 7905.565193914333, 7918.366530677561, 7804.882926756075, 7935.404844636675, 7940.086890007637, 7947.841043179133, 7960.52236865787, 7886.526808391515, 7906.80232994174, 7915.089764677078, 7968.521888686669, 7971.800704982393, 7894.447388682795, 7903.683852645887, 7911.129775724695, 7914.960425197837, 7962.402819788539, 7803.531788092732, 7838.37293016563, 7841.0, 7845.254700803414, 7855.685772569091, 38393.0, 38871.222575548614, 38965.22069558621, 39093.21813563741, 39264.0, 3127.671594482592, 3261.59230096238, 3398.320335932823, 3501.7373696972827, 3757.041954301663, 28286.434271314458, 28673.713262867313, 28735.856320718263, 28970.13089607315, 29805.10584682463, 3080.738137258336, 3093.8088835798153, 3195.9201019974453, 3228.9192770180935, 3232.095013396229, 250135.0, 250677.0, 252117.0, 252457.0, 252639.0, 31347.84326078355, 32496.0, 32557.67442325594, 51266.48733512692, 52155.73922130365, 33422.49866252008, 33513.329733405684, 33525.32949341, 33542.16144596405, 33563.496547551804, 13671.453141874214, 13783.793243101361, 13802.654933626538, 13822.516211932534, 13853.930730346283, 11397.430128493543, 11521.135914806424, 11530.711732206593, 11533.653990380302, 11565.76868462626, 7837.098733645704, 7837.333826624801, 7851.528908265408, 7887.881681774778, 7913.129555748863, 3084.491058975289, 3100.5039193728894, 3121.266502371941, 3123.7969531980348, 3167.2715275486767, 809.8015986083448, 902.5442151713343, 946.6308139825474, 948.2366694810605, 954.746992047108, 27724.0, 27818.860905695747, 27981.58027629587, 28572.428551428857, 28590.0, 960.1646567486332, 967.3760424526141, 998.8313673002605, 1016.2682868334787, 1018.1854516387009, 14668.559943201508, 14861.256937153099, 15114.523659558363, 15244.618884527754, 15320.463783767515, 120783.0, 416907.0, 417308.0, 417665.0, 418014.0, 48057.51942480601, 49628.25557616639, 49649.0, 49780.0, 49819.750901245265, 1187.091874715843, 1196.3061424374016, 1205.957791477294, 1207.3600991474532, 1213.7754515414854, 27138.864305678344, 27872.303192420353, 27951.301217469725, 28417.573736394384, 28594.285142871595, 42916.356254655584, 42937.0, 42999.355009674255, 43225.13549729051, 43469.34795978126, 322407.0, 331962.0, 333684.0, 334180.0, 336636.0, 23034.308970730905, 23253.534929300982, 23303.0, 23330.600163990213, 23414.76585234194, 40472.3929141069, 41988.00683054723, 42055.0, 42565.787171063945, 42716.572834272505, 35565.28869422649, 35751.46372804462, 35786.28427431489, 36250.27499450049, 36521.269574608894, 36516.634833651326, 36820.26359472742, 36912.630873692, 36968.81515592513, 37014.814925925195, 34816.0, 35992.820035899655, 36929.63070369262, 36944.0, 38599.61400386073, 29913.401731965674, 33404.0, 33435.33129337448, 33765.155871103416, 33863.83068084644, 25473.745262547138, 25761.098361558004, 25855.411401514684, 26145.0, 26361.604575930993], "value": 16436.30916395589, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.10626200154616, 363.82354558039356, 366.98165091745403, 384.43488072533364, 384.849908535671, 16337.918310408446, 16556.751648725265, 16924.4076457324, 17290.049047302393, 17299.91350043248, 16018.279177437014, 16314.510564683078, 16944.83055169448, 16965.32138714453, 16972.745408818846, 5115.488451154892, 5217.973910130444, 5251.028559716465, 5264.263003179539, 5269.99870024696, 5100.795968161269, 5135.35808023997, 5206.869828254305, 5221.765020574083, 5241.580673546107, 5021.84934451967, 5102.056119617882, 5142.794288228485, 5180.818671346504, 5194.532492075731, 5055.595552355802, 5079.619028572872, 5105.974470127663, 5109.3357863477695, 5158.148905430599, 4474.753888536129, 4552.453705555321, 4570.954290457119, 4583.495815460296, 4610.2854057621125, 19918.402447926586, 20052.298169563994, 20306.69539956902, 20688.0, 20699.896500517552, 1754.7017007108823, 1781.9287228510843, 1876.1744832273891, 1898.8670793044491, 1974.2695202774921, 9244.583993720298, 9284.164425201765, 9335.113164249386, 9364.063593640582, 9482.241420686329, 1737.1922056243782, 1767.5227688524026, 1799.8200179981898, 1810.2396993262862, 1834.3763120539081, 52072.47927520752, 68843.9999999995, 70462.0, 70600.0, 74090.0, 9600.567974441026, 9641.469719165372, 9872.111509964137, 10124.73805009489, 10162.644307449204, 13786.310684465736, 13816.447342106405, 13837.86162138386, 13896.58310250694, 13896.722065558835, 7244.203137654854, 7313.853722925512, 7427.85144297111, 7508.812279693051, 7611.200823913409, 7134.393576545948, 7271.309225623558, 7339.596322202224, 7469.365103966115, 7478.3643390311345, 4301.870943871689, 4309.633681137076, 4310.676699247506, 4353.804078816461, 4449.443819522559, 1763.1184407796102, 1778.9021603811914, 1807.0783900210988, 1839.2734869726382, 1843.15215001101, 833.795720048592, 854.5599016506504, 899.1772528136681, 940.1961323068678, 946.2004606107828, 16310.347586096661, 16440.342386304415, 16716.24776885043, 16740.6651866962, 16877.156142193086, 805.2591615713558, 849.6941101203562, 870.4951128345544, 900.2797761790541, 909.054583233443, 9100.544972751335, 9406.858897116548, 9429.481378524248, 9521.666741664147, 9558.713238602713, 388345.0, 391935.0, 395169.0, 395418.0, 401027.0, 65877.0, 71853.0, 73416.32918354061, 73422.0, 80082.0, 907.4283201582961, 914.2685851318919, 924.089771574998, 941.1905761045496, 941.3692825806726, 14742.63143421423, 14856.925715371353, 14994.700105997601, 15082.24588770535, 15376.23118844031, 35765.64234357623, 35971.28057438889, 36086.45870311895, 36105.27789444144, 36502.634973649925, 47253.2912006327, 50570.49429505658, 50777.49222507876, 51191.488085118675, 51660.0, 7304.853902922018, 7595.734149304748, 7634.8091297718, 7711.190325015793, 7859.0, 11051.502682379152, 11120.777584448104, 11169.72075698114, 11440.656780296604, 11639.0, 9771.0, 10310.793784124426, 10346.948265258625, 10395.220358472994, 10436.947815260875, 10064.245181611263, 10194.745131371776, 10259.7435064124, 10453.634122805664, 10533.9473302633, 10054.0, 10420.635277765241, 10479.895201047892, 10525.210609204494, 10559.788804224027, 7115.5730656160795, 7305.1233851938105, 7367.484276100836, 7565.363061643585, 7895.960520197362, 7797.064352277536, 9046.683366082156, 10545.9472702636, 10548.525316360936, 10560.788784224425], "value": 8099.459637043681, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1379.9236595455545, 1407.929603519824, 1493.6788590453057, 1691.4164613208438, 1711.8459338659527, 6643.833904152399, 7268.200497945222, 7519.060117485315, 7771.6891324347025, 7789.260020298069, 7799.298063174313, 7814.218578142183, 7860.056793184825, 7864.134945156043, 7896.052473703164, 2162.1891790578493, 2187.223535644847, 2197.5385169114506, 2206.1616585697493, 2208.580369729746, 2164.5562659654734, 2166.4042388343173, 2201.1635578480236, 2205.0, 2211.237123192496, 2141.582391433671, 2173.3262688566597, 2173.5544213436287, 2178.3791619388476, 2215.0253888289103, 2120.650092734697, 2127.946801329964, 2136.2736669532355, 2138.016512404296, 2138.272987184357, 2099.737532808399, 2100.5798840232014, 2105.210546045233, 2121.406006318218, 2133.1040962795664, 7904.170062143449, 7993.72021979228, 8002.439829211958, 8018.5990700464745, 8021.5187088774865, 4541.795619197144, 4668.2064049111395, 4694.08465349257, 4753.928691069636, 4760.595349395306, 2891.8120322178993, 2898.145047211057, 2900.6374203224595, 2942.6763056063814, 2952.099609619065, 906.9410488318305, 938.4134915677702, 949.1254771825658, 949.7768024514234, 952.4618590496348, 10342.43116628585, 10365.740856478573, 10403.11573516252, 10408.01123893229, 10491.16070714341, 3983.1237127831832, 4145.316022856195, 4171.49942006955, 4226.640735537514, 4252.510961239435, 9013.504257265782, 9066.909330906607, 9093.727188184233, 9111.134442227978, 9116.8632470513, 4687.296905464208, 4696.7651617419, 4701.529847015339, 4725.763711814396, 4733.810647574059, 3701.1857391373856, 4247.214265360918, 4248.87253382399, 4252.553481884358, 4412.691111622155, 3627.2745450909924, 3703.203811180609, 3746.119661879456, 3756.0, 3944.822482988215, 1212.593781083347, 1233.216907263876, 1245.6574442028514, 1246.8005119180887, 1251.6245126462024, 772.8686123359042, 778.4122987144669, 799.3605115907251, 832.0888626953597, 871.1941454154882, 5255.159174532057, 5285.339332583427, 5291.656042357235, 5493.807716729975, 5658.7170641467765, 869.6217145541709, 871.5511511571545, 893.3389291923929, 900.8513595256841, 901.7114523352465, 3672.5225720656144, 3678.6873115785456, 3695.667389934919, 3721.3115573618966, 3733.3653278942643, 9261.629534818667, 9519.714408567754, 9730.75673108178, 9770.316077874622, 9801.313908026512, 9605.18355939753, 9616.23070154386, 9676.806463870824, 9684.225261979025, 9748.658796942073, 7234.5659260444545, 7349.7060117595765, 7351.963240183765, 7399.371053460516, 7428.62856857155, 5144.0997825381155, 5249.432655173823, 5268.868278293074, 5281.973590132178, 5411.78352865881, 8718.564071796258, 8806.383553151218, 8816.779580510538, 8840.911590884009, 8886.289096872106, 8823.338249631175, 8831.63118169436, 8974.910250897408, 8980.146886045815, 9046.50244236547, 5556.194351819045, 6010.519158467399, 6193.535484838565, 6372.840678982877, 6487.448566871869, 7290.817729556804, 7304.525205861814, 7340.669669864976, 7346.77959661211, 7366.416220512616, 6407.327230640715, 6591.670416479061, 6610.2398224204835, 6642.966785166043, 6709.798706038827, 6600.966995164993, 6604.570702904296, 6614.272430032596, 6682.0, 6709.094272273181, 6070.3003159115515, 6137.355577664281, 6140.600860944024, 6147.877042459215, 6185.907211391923, 4398.120375924764, 4494.0, 4553.089382123522, 4577.267637178035, 4596.770161491979, 4514.68397212192, 4537.09258148365, 4574.382458368078, 4581.541845815392, 4591.380163677861], "value": 4135.698233984446, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.46667165780735, 301.6591251885369, 305.6286611766704, 307.6246978686002, 309.50942755732194, 5098.515641014107, 5115.872103197422, 5116.948830511694, 5135.871603209922, 5156.871078223046, 5001.724905130216, 5003.774830132644, 5021.38887778355, 5031.4465408805, 5043.722595257259, 3722.4788529605876, 3844.807759612022, 3945.0, 3964.583718709537, 3996.3406038003695, 3932.7640341579454, 3932.7976333253328, 3941.960580394202, 3947.4868267125235, 3963.009247688078, 3906.2187562487475, 3912.965258065804, 3933.272344616255, 3941.1723538057045, 3950.940735888964, 3818.8620823119695, 3913.7064720146104, 3956.8615098471705, 3957.6240257175523, 3960.5444624332954, 3453.3611281912927, 3458.8443520041405, 3459.446488561843, 3469.5663042119736, 3473.496343030272, 4875.829345972874, 4879.780409881564, 4887.657863949525, 4892.339534162878, 4897.559219670246, 4415.646748260164, 4455.643548516144, 4519.254323036695, 4527.320901864714, 4540.7502587357685, 5246.449122842085, 5247.553957913582, 5288.471152884719, 5296.788128474856, 5318.149096144598, 3810.6760925321382, 3814.9618503814886, 3816.427535869642, 3819.1216020315205, 3824.426336049587, 5391.272178255925, 5541.89408024952, 5542.418046105141, 5544.279243698334, 5555.2778138841695, 3864.8840534784003, 3872.9473379109118, 3876.1472476055787, 3885.0, 3886.4170374443493, 3937.409388591734, 3950.229705207457, 3954.307996100671, 3960.1683646433994, 3970.5433875104154, 4481.843135490308, 4482.641388688897, 4484.304932735431, 4493.550644935545, 4494.775261236925, 5165.767540460688, 5219.5041471060185, 5257.237700533401, 5270.156774915995, 5300.628955973045, 1358.2190240611687, 1373.921471644774, 1374.10373684317, 1380.3305396882504, 1381.2955392749568, 840.7682744778929, 866.2593482572436, 872.5724395046509, 877.1886005445066, 888.7955770172896, 4504.549545045469, 4570.337301091323, 4620.653450991122, 4647.34937108805, 4652.464966528893, 5453.89128196924, 5481.698506582096, 5512.924979628934, 5525.546533416615, 5531.3915469298345, 4418.756968366706, 4670.556297151765, 4686.109639168547, 4697.553732395417, 4715.575598196178, 2887.6246088008425, 2901.63623097144, 2907.418516296707, 2942.161483977099, 2947.3810499794854, 5091.465396133427, 5137.563307118862, 5154.664946778447, 5161.0, 5192.766325515361, 5438.728063596884, 5492.5605951523785, 5524.867402182543, 5543.417941116206, 5591.832245032656, 5056.002878862829, 5066.189409694432, 5086.567641750418, 5086.771095300646, 5109.948900511022, 5441.918371224514, 5450.874159077884, 5451.64564303319, 5474.890502190014, 5491.780328786804, 5069.0, 5321.920171197357, 5365.356157261153, 5411.404745477916, 5419.918701219406, 5112.642115052059, 5121.871953201051, 5175.14610089331, 5208.255234496486, 5211.557017653542, 3790.8673196437994, 3821.694264458892, 3824.9617503824607, 3834.482344883405, 3835.8273877675015, 5217.34783152106, 5439.537639300704, 5481.588880833874, 5502.8349149525575, 5555.611107222456, 5303.992241474108, 5327.866803329948, 5330.546903513245, 5346.518813306821, 5353.411124776349, 5167.173252279617, 5320.856015956588, 5333.093374126331, 5375.758090885998, 5375.81184658535, 5221.947780522298, 5243.5542978847225, 5253.947460525345, 5258.1849813279005, 5281.808049659348, 5089.3638295213095, 5199.792008319776, 5272.420033796203, 5290.65610735301, 5300.098983172947, 5210.244514545446, 5227.18978558324, 5229.973850130725, 5238.135707608202, 5238.4237733850005], "value": 3988.3219634613392, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [621.2265729167186, 643.4833634189158, 666.623357802841, 730.6711979609178, 747.1669088965803, 12027.819582706266, 13275.13711608746, 13532.391042403091, 13565.389557469913, 13596.864031359684, 12968.481260749559, 13142.802857957115, 13143.868561314384, 13170.27563484008, 13226.0, 614.3273115938041, 736.4476642518111, 749.3368368993425, 767.869462191426, 770.603139383218, 761.0220866186951, 764.2128607534221, 766.5017738469984, 767.6583920155533, 767.9193684663114, 804.5574933786394, 806.1696452653777, 806.3549160671469, 807.1645846548823, 809.1261437647327, 799.5083023940235, 801.1587832775591, 802.2779498451412, 804.7103042904549, 805.5730462854697, 584.0567483514094, 584.7777844419094, 585.4906231578553, 588.0825911577953, 588.4703766610043, 13153.079284450092, 13190.340482975813, 13236.536721214712, 13236.801447978289, 13256.138351007154, 13291.202527848263, 13374.465021399132, 13467.124636898669, 13504.864951350459, 13548.593542193652, 9598.0, 9916.454594997344, 10078.647247346307, 10179.84730229047, 10235.79528409435, 3277.2953814929906, 3297.258116923697, 3327.8336083195986, 3334.683205095512, 3396.2018925552475, 59711.402885971016, 59737.70131149316, 59810.70094649499, 60841.39158608446, 60946.0, 10153.441560714231, 10282.897171028193, 10387.0, 10437.425941573287, 10500.422476763699, 18751.34370297033, 19023.524411889535, 19110.331138410365, 19112.61774764497, 19112.904435478013, 7080.221175670672, 7133.357997780225, 7151.642417879085, 7185.56886586796, 7238.6018768968215, 3671.8714844980295, 3752.4934133891575, 3762.5673047599876, 3782.7541209821825, 3831.1762970961377, 2755.3662657588866, 2840.1905456944673, 2842.1189431275957, 2852.700466451034, 2853.22962800047, 556.6131538580647, 575.6517307029271, 578.4880380862967, 583.8102616649521, 589.2957915291272, 564.3989151553583, 566.6996491859321, 581.0586849304154, 593.8307582339013, 602.9246344206974, 8118.512889226666, 8436.198561136682, 8528.147185281547, 8575.056743758181, 8620.396572240008, 525.8606469285643, 602.8854517641633, 606.8634557224589, 628.2368612014003, 629.5026928726255, 3705.5182826232417, 3779.5842457329672, 3782.08371779225, 3819.1216020315483, 4216.746995180238, 59935.400645993854, 61148.082778758355, 75839.62080189564, 78378.0, 80005.19994800094, 78394.6080269595, 81646.59176704197, 82483.58758206171, 83437.58281208554, 84908.0, 52735.0, 66861.66569167122, 74550.0, 74605.0, 75657.24342756612, 8152.385128199942, 8692.869606955774, 8766.34252431083, 8802.0, 8887.377883548348, 44564.55435445734, 45895.0, 46074.0, 46675.29987050265, 46760.53239467698, 57160.0, 57703.711481442326, 65391.67304163449, 65525.0, 66566.0, 11742.530298788295, 11885.702857428634, 12000.75998480043, 12170.634880953585, 12340.876591233973, 12603.432845521791, 12717.93641031826, 12856.035797315426, 13272.203667779964, 13973.231472269123, 11669.88330116688, 11912.821307680219, 12474.18917770342, 12930.806037909251, 13042.54351097707, 11351.599816135835, 11595.478203481032, 12101.152919295564, 12486.625401237614, 12672.0, 11445.885541144482, 11815.645530634094, 12296.631101066982, 12329.938350308192, 12611.558595449114, 9596.712098637052, 9940.45327506994, 10053.949730251303, 10063.547140378847, 10108.646197383056, 10220.642277520252, 10575.788484230427, 10582.922987978696, 10695.251332406657, 10741.731456713645], "value": 6565.743408624236, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1577.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 110.0, 116.0, 115.0, 115.0, 116.0, 116.0, 116.0, 113.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 128.0, 153.0, 177.0, 124.0, 163.0, 149.0, 125.0, 176.0, 123.0], "value": 146.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 163.0, 165.0, 192.0, 164.0, 163.0, 163.0, 163.0, 165.0], "value": 166.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 76.0, 161.0, 77.0, 77.0, 76.0, 77.0, 166.0, 78.0], "value": 94.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 149.0, 86.0, 86.0, 85.0, 132.0, 86.0, 86.0, 146.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 150.0, 148.0, 148.0, 148.0, 148.0, 149.0, 148.0, 149.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 95.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 63.0, 65.0, 72.0, 63.0, 62.0, 64.0, 63.0, 70.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 69.0, 68.0, 67.0, 68.0, 68.0, 70.0, 68.0], "value": 68.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 80.0, 86.0, 80.0, 79.0, 79.0, 79.0, 83.0, 90.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 144.0, 135.0, 140.0, 137.0, 131.0, 142.0, 131.0, 166.0, 141.0], "value": 141.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 172.0, 165.0, 168.0, 172.0, 165.0, 168.0, 166.0, 166.0, 167.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 71.0, 66.0, 69.0], "value": 67.8, "unit": "score"}]}]} 02:46:23 INFO - Return code: 0 02:46:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:46:23 ERROR - # TBPL SUCCESS # 02:46:23 INFO - Running post-action listener: _resource_record_post_action 02:46:23 INFO - ##### 02:46:23 INFO - ##### Finished run-tests step (success) 02:46:23 INFO - ##### 02:46:23 INFO - Running post-run listener: _resource_record_post_run 02:46:23 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 542642176; Read time: 0; Write time: 426264 02:46:23 INFO - TinderboxPrint: CPU usage
13.3% 02:46:23 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 02:46:23 INFO - TinderboxPrint: I/O write bytes / time
542,642,176 / 426,264 02:46:23 INFO - TinderboxPrint: CPU idle
8,273.2 (86.7%) 02:46:23 INFO - TinderboxPrint: CPU user
1,220.3 (12.8%) 02:46:23 INFO - TinderboxPrint: Swap in / out
0 / 0 02:46:23 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 257925120; Read time: 0; Write time: 237796 02:46:23 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 284180480; Read time: 0; Write time: 188468 02:46:23 INFO - Running post-run listener: _upload_blobber_files 02:46:23 INFO - Blob upload gear active. 02:46:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:46:23 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 02:46:23 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'] 02:46:23 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 02:46:24 INFO - (blobuploader) - INFO - Open directory for files ... 02:46:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:46:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:46:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:24 INFO - (blobuploader) - INFO - Done attempting. 02:46:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:46:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:46:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:36 INFO - (blobuploader) - INFO - Done attempting. 02:46:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:46:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:46:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:46:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:46:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:46:37 INFO - (blobuploader) - INFO - Done attempting. 02:46:37 INFO - (blobuploader) - INFO - Iteration through files over. 02:46:37 INFO - Return code: 0 02:46:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:46:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:46:37 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2ce6dd8153624ba99411803315ad17fb0651a82942680ad35e632970682fcb800350152cb4a5c3da29a3b9a9022a90029a57d179ba5b693fca3a605ba12a39c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7f7a1285bf7dad0543082a6d4d50a6e722ad8a253bb30e0ae28d29e178b2c46b4ecaccf8141e3286cdc01de419d5e0dd11f625903e8fdd77ef0483c230ddba7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c5d06a071821af81efbe62aacf2955d2b23576abdf19f848836ff181dbae93edf680ac221ba739ef5ffc81e82fbcd878f042485ac248e4452b3036952e65e31d"} 02:46:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:46:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:46:37 INFO - Contents: 02:46:37 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2ce6dd8153624ba99411803315ad17fb0651a82942680ad35e632970682fcb800350152cb4a5c3da29a3b9a9022a90029a57d179ba5b693fca3a605ba12a39c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7f7a1285bf7dad0543082a6d4d50a6e722ad8a253bb30e0ae28d29e178b2c46b4ecaccf8141e3286cdc01de419d5e0dd11f625903e8fdd77ef0483c230ddba7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c5d06a071821af81efbe62aacf2955d2b23576abdf19f848836ff181dbae93edf680ac221ba739ef5ffc81e82fbcd878f042485ac248e4452b3036952e65e31d"} 02:46:37 INFO - Running post-run listener: copy_logs_to_upload_dir 02:46:37 INFO - Copying logs to upload dir... 02:46:37 INFO - mkdir: /builds/slave/test/build/upload/logs 02:46:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.251041 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-19 02:46:36.665463) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 02:46:36.668776) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686 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/2ce6dd8153624ba99411803315ad17fb0651a82942680ad35e632970682fcb800350152cb4a5c3da29a3b9a9022a90029a57d179ba5b693fca3a605ba12a39c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7f7a1285bf7dad0543082a6d4d50a6e722ad8a253bb30e0ae28d29e178b2c46b4ecaccf8141e3286cdc01de419d5e0dd11f625903e8fdd77ef0483c230ddba7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c5d06a071821af81efbe62aacf2955d2b23576abdf19f848836ff181dbae93edf680ac221ba739ef5ffc81e82fbcd878f042485ac248e4452b3036952e65e31d"} build_url:https://queue.taskcluster.net/v1/task/DLN5MBsCTZGv47sNJstPkQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011233 build_url: 'https://queue.taskcluster.net/v1/task/DLN5MBsCTZGv47sNJstPkQ/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/2ce6dd8153624ba99411803315ad17fb0651a82942680ad35e632970682fcb800350152cb4a5c3da29a3b9a9022a90029a57d179ba5b693fca3a605ba12a39c2", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7f7a1285bf7dad0543082a6d4d50a6e722ad8a253bb30e0ae28d29e178b2c46b4ecaccf8141e3286cdc01de419d5e0dd11f625903e8fdd77ef0483c230ddba7a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c5d06a071821af81efbe62aacf2955d2b23576abdf19f848836ff181dbae93edf680ac221ba739ef5ffc81e82fbcd878f042485ac248e4452b3036952e65e31d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 02:46:36.693632) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 02:46:36.693925) ========= 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=2c5dd2b0a310ecf02fd87158000001b4-1468920353.112242-932387686 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004392 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 02:46:36.777196) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 02:46:36.777525) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 02:46:36.777813) ========= ========= Total master_lag: 0.16 =========