builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1467385080.55 results: success (0) buildid: 20160701062824 builduid: cfc76114afd049ed9a60c56551be14d0 revision: 649dfb23aea44a0e98e2caf7f19691af92af64c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 07:58:00.548847) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 07:58:00.549586) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 07:58:00.550288) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 07:58:00.576608) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 07:58:00.576899) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-01 07:58:01-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 51.0M=0s 2016-07-01 07:58:01 (51.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.140677 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 07:58:00.734831) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 07:58:00.735109) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020595 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 07:58:00.784444) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 07:58:00.784828) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 649dfb23aea44a0e98e2caf7f19691af92af64c4 --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 649dfb23aea44a0e98e2caf7f19691af92af64c4 --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=e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-01 07:58:01,324 truncating revision to first 12 chars 2016-07-01 07:58:01,324 Setting DEBUG logging. 2016-07-01 07:58:01,324 attempt 1/10 2016-07-01 07:58:01,324 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/649dfb23aea4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 07:58:02,555 unpacking tar archive at: fx-team-649dfb23aea4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.564715 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 07:58:02.363333) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 07:58:02.363653) ========= script_repo_revision: 649dfb23aea44a0e98e2caf7f19691af92af64c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 07:58:02.364065) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 07:58:02.364331) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 07:58:02.374702) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-01 07:58:02.375031) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:58:02 INFO - MultiFileLogger online at 20160701 07:58:02 in /builds/slave/test 07:58:02 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 07:58:02 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:58:03 INFO - {'append_to_log': False, 07:58:03 INFO - 'base_work_dir': '/builds/slave/test', 07:58:03 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 07:58:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:58:03 INFO - 'branch': 'Fx-Team-Non-PGO', 07:58:03 INFO - 'buildbot_json_path': 'buildprops.json', 07:58:03 INFO - 'config_files': ('talos/linux_config.py',), 07:58:03 INFO - 'default_actions': ('clobber', 07:58:03 INFO - 'read-buildbot-config', 07:58:03 INFO - 'download-and-extract', 07:58:03 INFO - 'populate-webroot', 07:58:03 INFO - 'create-virtualenv', 07:58:03 INFO - 'install', 07:58:03 INFO - 'run-tests'), 07:58:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:58:03 INFO - 'download_minidump_stackwalk': True, 07:58:03 INFO - 'download_symbols': 'ondemand', 07:58:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:58:03 INFO - 'tooltool.py': '/tools/tooltool.py', 07:58:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:58:03 INFO - '/tools/misc-python/virtualenv.py')}, 07:58:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:58:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:58:03 INFO - 'installer_path': 'installer.exe', 07:58:03 INFO - 'log_level': 'info', 07:58:03 INFO - 'log_name': 'talos', 07:58:03 INFO - 'log_to_console': True, 07:58:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:58:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:58:03 INFO - 'opt_config_files': (), 07:58:03 INFO - 'pip_index': False, 07:58:03 INFO - 'sps_profile': False, 07:58:03 INFO - 'sps_profile_interval': 0, 07:58:03 INFO - 'suite': 'dromaeojs', 07:58:03 INFO - 'system_bits': '32', 07:58:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:58:03 INFO - 'title': 'talos-linux64-ix-006', 07:58:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:58:03 INFO - 'use_talos_json': True, 07:58:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:58:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:58:03 INFO - 'work_dir': 'build'} 07:58:03 INFO - ##### 07:58:03 INFO - ##### Running clobber step. 07:58:03 INFO - ##### 07:58:03 INFO - Running pre-action listener: _resource_record_pre_action 07:58:03 INFO - Running main action method: clobber 07:58:03 INFO - rmtree: /builds/slave/test/build 07:58:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:58:04 INFO - Running post-action listener: _resource_record_post_action 07:58:04 INFO - ##### 07:58:04 INFO - ##### Finished clobber step (success) 07:58:04 INFO - ##### 07:58:04 INFO - ##### 07:58:04 INFO - ##### Running read-buildbot-config step. 07:58:04 INFO - ##### 07:58:04 INFO - Running pre-action listener: _resource_record_pre_action 07:58:04 INFO - Running main action method: read_buildbot_config 07:58:04 INFO - Using buildbot properties: 07:58:04 INFO - { 07:58:04 INFO - "project": "", 07:58:04 INFO - "product": "firefox", 07:58:04 INFO - "script_repo_revision": "production", 07:58:04 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 07:58:04 INFO - "repository": "", 07:58:04 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 07:58:04 INFO - "buildid": "20160701062824", 07:58:04 INFO - "pgo_build": "False", 07:58:04 INFO - "basedir": "/builds/slave/test", 07:58:04 INFO - "buildnumber": 1918, 07:58:04 INFO - "slavename": "talos-linux64-ix-006", 07:58:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:58:04 INFO - "platform": "ubuntu64_hw", 07:58:04 INFO - "scheduler": "tests-fx-team-linux64-talos", 07:58:04 INFO - "branch": "fx-team", 07:58:04 INFO - "repo_path": "integration/fx-team", 07:58:04 INFO - "revision": "649dfb23aea44a0e98e2caf7f19691af92af64c4", 07:58:04 INFO - "stage_platform": "linux64", 07:58:04 INFO - "builduid": "cfc76114afd049ed9a60c56551be14d0", 07:58:04 INFO - "slavebuilddir": "test" 07:58:04 INFO - } 07:58:04 INFO - Found installer url https://queue.taskcluster.net/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:58:04 INFO - Running post-action listener: _resource_record_post_action 07:58:04 INFO - ##### 07:58:04 INFO - ##### Finished read-buildbot-config step (success) 07:58:04 INFO - ##### 07:58:04 INFO - ##### 07:58:04 INFO - ##### Running download-and-extract step. 07:58:04 INFO - ##### 07:58:04 INFO - Running pre-action listener: _resource_record_pre_action 07:58:04 INFO - Running main action method: download_and_extract 07:58:04 INFO - mkdir: /builds/slave/test/build/tests 07:58:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:04 INFO - https://queue.taskcluster.net/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:58:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:58:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:58:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:58:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:58:05 INFO - Downloaded 1361 bytes. 07:58:05 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:58:05 INFO - Using the following test package requirements: 07:58:05 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:58:05 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:58:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:58:05 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:58:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:58:05 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:58:05 INFO - u'jsshell-linux-x86_64.zip'], 07:58:05 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:58:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:58:05 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:58:05 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:58:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:58:05 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:58:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:58:05 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:58:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:58:05 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:58:05 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:58:05 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:05 INFO - https://queue.taskcluster.net/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:58:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:58:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:58:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:58:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:58:06 INFO - Downloaded 22704123 bytes. 07:58:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:58:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:58:07 INFO - Return code: 0 07:58:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:58:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:07 INFO - https://queue.taskcluster.net/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:58:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:58:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:58:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:58:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:58:10 INFO - Downloaded 22704123 bytes. 07:58:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:58:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:58:11 INFO - Return code: 0 07:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:11 INFO - https://queue.taskcluster.net/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:58:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:58:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:58:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:58:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:58:12 INFO - Downloaded 14405242 bytes. 07:58:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:58:12 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 07:58:12 INFO - Return code: 0 07:58:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:12 INFO - https://queue.taskcluster.net/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:58:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:58:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:58:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:58:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:58:14 INFO - Downloaded 56452257 bytes. 07:58:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:58:14 INFO - mkdir: /builds/slave/test/properties 07:58:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:58:14 INFO - Writing to file /builds/slave/test/properties/build_url 07:58:14 INFO - Contents: 07:58:14 INFO - build_url:https://queue.taskcluster.net/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:58:15 INFO - Running post-action listener: _resource_record_post_action 07:58:15 INFO - Running post-action listener: set_extra_try_arguments 07:58:15 INFO - ##### 07:58:15 INFO - ##### Finished download-and-extract step (success) 07:58:15 INFO - ##### 07:58:15 INFO - ##### 07:58:15 INFO - ##### Running populate-webroot step. 07:58:15 INFO - ##### 07:58:15 INFO - Running pre-action listener: _resource_record_pre_action 07:58:15 INFO - Running main action method: populate_webroot 07:58:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:58:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:58:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:58:15 INFO - '--tppagecycles', 07:58:15 INFO - '7'], 07:58:15 INFO - 'tests': ['tsvgm']}}, 07:58:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:58:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:58:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:58:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:58:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:58:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:58:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:15 INFO - 'talos_options': ['--disable-e10s'], 07:58:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:58:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:58:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:15 INFO - 'talos_options': ['--disable-e10s'], 07:58:15 INFO - 'tests': ['damp', 'tps']}, 07:58:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:15 INFO - 'tests': ['damp', 'tps']}, 07:58:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:58:15 INFO - 'tests': ['dromaeo_dom']}, 07:58:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:58:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:58:15 INFO - 'tests': ['basic_compositor_video']}, 07:58:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:58:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:58:15 INFO - 'tests': ['a11yr', 07:58:15 INFO - 'ts_paint', 07:58:15 INFO - 'tpaint', 07:58:15 INFO - 'sessionrestore', 07:58:15 INFO - 'sessionrestore_no_auto_restore', 07:58:15 INFO - 'tabpaint']}, 07:58:15 INFO - 'other-e10s': {'tests': ['a11yr', 07:58:15 INFO - 'ts_paint', 07:58:15 INFO - 'tpaint', 07:58:15 INFO - 'sessionrestore', 07:58:15 INFO - 'sessionrestore_no_auto_restore', 07:58:15 INFO - 'tabpaint']}, 07:58:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:58:15 INFO - 'ts_paint', 07:58:15 INFO - 'tpaint', 07:58:15 INFO - 'sessionrestore', 07:58:15 INFO - 'sessionrestore_no_auto_restore', 07:58:15 INFO - 'tabpaint']}, 07:58:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:58:15 INFO - 'ts_paint', 07:58:15 INFO - 'tpaint', 07:58:15 INFO - 'sessionrestore', 07:58:15 INFO - 'sessionrestore_no_auto_restore', 07:58:15 INFO - 'tabpaint']}, 07:58:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:58:15 INFO - 'tests': ['a11yr', 07:58:15 INFO - 'ts_paint', 07:58:15 INFO - 'tpaint', 07:58:15 INFO - 'sessionrestore', 07:58:15 INFO - 'sessionrestore_no_auto_restore', 07:58:15 INFO - 'tabpaint']}, 07:58:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:58:15 INFO - 'tests': ['a11yr', 07:58:15 INFO - 'ts_paint', 07:58:15 INFO - 'tpaint', 07:58:15 INFO - 'sessionrestore', 07:58:15 INFO - 'sessionrestore_no_auto_restore', 07:58:15 INFO - 'tabpaint']}, 07:58:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:58:15 INFO - 'tests': ['tsvgx', 07:58:15 INFO - 'tsvgr_opacity', 07:58:15 INFO - 'tart', 07:58:15 INFO - 'tscrollx', 07:58:15 INFO - 'cart']}, 07:58:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:58:15 INFO - 'tsvgr_opacity', 07:58:15 INFO - 'tart', 07:58:15 INFO - 'tscrollx', 07:58:15 INFO - 'cart']}, 07:58:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:15 INFO - 'talos_options': ['--disable-e10s'], 07:58:15 INFO - 'tests': ['tp5o']}, 07:58:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:15 INFO - 'tests': ['tp5o']}, 07:58:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:15 INFO - 'talos_options': ['--disable-e10s', 07:58:15 INFO - '--xperf_path', 07:58:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:58:15 INFO - 'tests': ['tp5n']}, 07:58:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:15 INFO - 'talos_options': ['--xperf_path', 07:58:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:58:15 INFO - 'tests': ['tp5n']}}, 07:58:15 INFO - 'talos.zip': {'path': '', 07:58:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:58:15 INFO - Running post-action listener: _resource_record_post_action 07:58:15 INFO - ##### 07:58:15 INFO - ##### Finished populate-webroot step (success) 07:58:15 INFO - ##### 07:58:15 INFO - ##### 07:58:15 INFO - ##### Running create-virtualenv step. 07:58:15 INFO - ##### 07:58:15 INFO - Running pre-action listener: _resource_record_pre_action 07:58:15 INFO - Running main action method: create_virtualenv 07:58:15 INFO - Creating virtualenv /builds/slave/test/build/venv 07:58:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:58:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:58:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:58:15 INFO - Using real prefix '/usr' 07:58:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:58:15 INFO - Installing distribute.............................................................................................................................................................................................done. 07:58:17 INFO - Installing pip.................done. 07:58:17 INFO - Return code: 0 07:58:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df13b0>, '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 0x1df22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df2740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:58:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:58:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:58:17 INFO - Using env: {'DISPLAY': ':0', 07:58:17 INFO - 'HOME': '/home/cltbld', 07:58:17 INFO - 'LANG': 'en_US.UTF-8', 07:58:17 INFO - 'LANGUAGE': 'en_US:en', 07:58:17 INFO - 'LOGNAME': 'cltbld', 07:58:17 INFO - 'MAIL': '/var/mail/cltbld', 07:58:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:17 INFO - 'MOZ_NO_REMOTE': '1', 07:58:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:17 INFO - 'NO_EM_RESTART': '1', 07:58:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:17 INFO - 'PWD': '/builds/slave/test', 07:58:17 INFO - 'SHELL': '/bin/bash', 07:58:17 INFO - 'SHLVL': '1', 07:58:17 INFO - 'TERM': 'linux', 07:58:17 INFO - 'TMOUT': '86400', 07:58:17 INFO - 'USER': 'cltbld', 07:58:17 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795', 07:58:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:17 INFO - '_': '/tools/buildbot/bin/python'} 07:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:58:18 INFO - Cleaning up... 07:58:18 INFO - Return code: 0 07:58:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1b32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df13b0>, '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 0x1df22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df2740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:58:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:58:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:58:18 INFO - Using env: {'DISPLAY': ':0', 07:58:18 INFO - 'HOME': '/home/cltbld', 07:58:18 INFO - 'LANG': 'en_US.UTF-8', 07:58:18 INFO - 'LANGUAGE': 'en_US:en', 07:58:18 INFO - 'LOGNAME': 'cltbld', 07:58:18 INFO - 'MAIL': '/var/mail/cltbld', 07:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:18 INFO - 'MOZ_NO_REMOTE': '1', 07:58:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:18 INFO - 'NO_EM_RESTART': '1', 07:58:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:18 INFO - 'PWD': '/builds/slave/test', 07:58:18 INFO - 'SHELL': '/bin/bash', 07:58:18 INFO - 'SHLVL': '1', 07:58:18 INFO - 'TERM': 'linux', 07:58:18 INFO - 'TMOUT': '86400', 07:58:18 INFO - 'USER': 'cltbld', 07:58:18 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795', 07:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:18 INFO - '_': '/tools/buildbot/bin/python'} 07:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:18 INFO - Downloading/unpacking psutil>=3.1.1 07:58: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 07:58: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 07:58: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 07:58: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 07:58: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 07:58: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 07:58:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:58:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:58:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:58:20 INFO - Installing collected packages: psutil 07:58:20 INFO - Running setup.py install for psutil 07:58:20 INFO - building 'psutil._psutil_linux' extension 07:58:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:58:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:58:20 INFO - building 'psutil._psutil_posix' extension 07:58:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:58:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:58:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:58:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:58:20 INFO - Successfully installed psutil 07:58:20 INFO - Cleaning up... 07:58:20 INFO - Return code: 0 07:58:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:20 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 0x1b32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df13b0>, '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 0x1df22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df2740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:58:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:58:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:58:20 INFO - Using env: {'DISPLAY': ':0', 07:58:20 INFO - 'HOME': '/home/cltbld', 07:58:20 INFO - 'LANG': 'en_US.UTF-8', 07:58:20 INFO - 'LANGUAGE': 'en_US:en', 07:58:20 INFO - 'LOGNAME': 'cltbld', 07:58:20 INFO - 'MAIL': '/var/mail/cltbld', 07:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:20 INFO - 'MOZ_NO_REMOTE': '1', 07:58:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:20 INFO - 'NO_EM_RESTART': '1', 07:58:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:20 INFO - 'PWD': '/builds/slave/test', 07:58:20 INFO - 'SHELL': '/bin/bash', 07:58:20 INFO - 'SHLVL': '1', 07:58:20 INFO - 'TERM': 'linux', 07:58:20 INFO - 'TMOUT': '86400', 07:58:20 INFO - 'USER': 'cltbld', 07:58:20 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795', 07:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:20 INFO - '_': '/tools/buildbot/bin/python'} 07:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:58:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:58:23 INFO - Installing collected packages: mozsystemmonitor 07:58:23 INFO - Running setup.py install for mozsystemmonitor 07:58:23 INFO - Successfully installed mozsystemmonitor 07:58:23 INFO - Cleaning up... 07:58:23 INFO - Return code: 0 07:58:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:23 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 0x1b32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df13b0>, '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 0x1df22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df2740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:58:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:58:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:58:23 INFO - Using env: {'DISPLAY': ':0', 07:58:23 INFO - 'HOME': '/home/cltbld', 07:58:23 INFO - 'LANG': 'en_US.UTF-8', 07:58:23 INFO - 'LANGUAGE': 'en_US:en', 07:58:23 INFO - 'LOGNAME': 'cltbld', 07:58:23 INFO - 'MAIL': '/var/mail/cltbld', 07:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:23 INFO - 'MOZ_NO_REMOTE': '1', 07:58:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:23 INFO - 'NO_EM_RESTART': '1', 07:58:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:23 INFO - 'PWD': '/builds/slave/test', 07:58:23 INFO - 'SHELL': '/bin/bash', 07:58:23 INFO - 'SHLVL': '1', 07:58:23 INFO - 'TERM': 'linux', 07:58:23 INFO - 'TMOUT': '86400', 07:58:23 INFO - 'USER': 'cltbld', 07:58:23 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795', 07:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:23 INFO - '_': '/tools/buildbot/bin/python'} 07:58:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:23 INFO - Downloading/unpacking jsonschema==2.5.1 07:58: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 07:58: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 07:58: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 07:58: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 07:58: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 07:58: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 07:58:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:58:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:25 INFO - Downloading functools32-3.2.3-2.tar.gz 07:58:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:58:25 INFO - warning: no files found matching '*.txt' 07:58:25 INFO - no previously-included directories found matching 'build' 07:58:25 INFO - no previously-included directories found matching 'dist' 07:58:25 INFO - no previously-included directories found matching '.git*' 07:58:25 INFO - Installing collected packages: jsonschema, functools32 07:58:25 INFO - Running setup.py install for functools32 07:58:25 INFO - warning: no files found matching '*.txt' 07:58:25 INFO - no previously-included directories found matching 'build' 07:58:25 INFO - no previously-included directories found matching 'dist' 07:58:25 INFO - no previously-included directories found matching '.git*' 07:58:25 INFO - Successfully installed jsonschema functools32 07:58:25 INFO - Cleaning up... 07:58:25 INFO - Return code: 0 07:58:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:25 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 0x1b32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df13b0>, '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 0x1df22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df2740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:58:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:58:25 INFO - Using env: {'DISPLAY': ':0', 07:58:25 INFO - 'HOME': '/home/cltbld', 07:58:25 INFO - 'LANG': 'en_US.UTF-8', 07:58:25 INFO - 'LANGUAGE': 'en_US:en', 07:58:25 INFO - 'LOGNAME': 'cltbld', 07:58:25 INFO - 'MAIL': '/var/mail/cltbld', 07:58:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:25 INFO - 'MOZ_NO_REMOTE': '1', 07:58:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:25 INFO - 'NO_EM_RESTART': '1', 07:58:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:25 INFO - 'PWD': '/builds/slave/test', 07:58:25 INFO - 'SHELL': '/bin/bash', 07:58:25 INFO - 'SHLVL': '1', 07:58:25 INFO - 'TERM': 'linux', 07:58:25 INFO - 'TMOUT': '86400', 07:58:25 INFO - 'USER': 'cltbld', 07:58:25 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795', 07:58:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:25 INFO - '_': '/tools/buildbot/bin/python'} 07:58:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:25 INFO - Downloading/unpacking blobuploader==1.2.4 07:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:27 INFO - Downloading blobuploader-1.2.4.tar.gz 07:58:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:58:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:58:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:28 INFO - Downloading docopt-0.6.1.tar.gz 07:58:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:58:28 INFO - Installing collected packages: blobuploader, requests, docopt 07:58:28 INFO - Running setup.py install for blobuploader 07:58:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:58:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:58:28 INFO - Running setup.py install for requests 07:58:29 INFO - Running setup.py install for docopt 07:58:29 INFO - Successfully installed blobuploader requests docopt 07:58:29 INFO - Cleaning up... 07:58:29 INFO - Return code: 0 07:58:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:29 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 0x1b32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df13b0>, '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 0x1df22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df2740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:58:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:58:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:58:29 INFO - Using env: {'DISPLAY': ':0', 07:58:29 INFO - 'HOME': '/home/cltbld', 07:58:29 INFO - 'LANG': 'en_US.UTF-8', 07:58:29 INFO - 'LANGUAGE': 'en_US:en', 07:58:29 INFO - 'LOGNAME': 'cltbld', 07:58:29 INFO - 'MAIL': '/var/mail/cltbld', 07:58:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:29 INFO - 'MOZ_NO_REMOTE': '1', 07:58:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:29 INFO - 'NO_EM_RESTART': '1', 07:58:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:29 INFO - 'PWD': '/builds/slave/test', 07:58:29 INFO - 'SHELL': '/bin/bash', 07:58:29 INFO - 'SHLVL': '1', 07:58:29 INFO - 'TERM': 'linux', 07:58:29 INFO - 'TMOUT': '86400', 07:58:29 INFO - 'USER': 'cltbld', 07:58:29 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795', 07:58:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:29 INFO - '_': '/tools/buildbot/bin/python'} 07:58:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:58:29 INFO - Running setup.py (path:/tmp/pip-MrljLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:58:29 INFO - Running setup.py (path:/tmp/pip-MxxFzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:58:29 INFO - Running setup.py (path:/tmp/pip-51R9Z8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:58:29 INFO - Running setup.py (path:/tmp/pip-sZLyYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:58:29 INFO - Running setup.py (path:/tmp/pip-jastmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:58:29 INFO - Running setup.py (path:/tmp/pip-21oZZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:58:29 INFO - Running setup.py (path:/tmp/pip-lFmNcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:58:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:58:29 INFO - Running setup.py (path:/tmp/pip-sTQ7_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:58:30 INFO - Running setup.py (path:/tmp/pip-b0j34K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:58:30 INFO - Running setup.py (path:/tmp/pip-9NUsiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:58:30 INFO - Running setup.py (path:/tmp/pip-KQdVxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:58:30 INFO - Running setup.py (path:/tmp/pip-ioqNkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:58:30 INFO - Running setup.py (path:/tmp/pip-E8iIRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:58:30 INFO - Running setup.py (path:/tmp/pip-Pw4lzb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:58:30 INFO - Running setup.py (path:/tmp/pip-xq2GKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:58:30 INFO - Running setup.py (path:/tmp/pip-4wzMvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:58:30 INFO - Running setup.py (path:/tmp/pip-zUq1jH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:58:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:58:30 INFO - Running setup.py install for manifestparser 07:58:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:58:30 INFO - Running setup.py install for mozcrash 07:58:30 INFO - Running setup.py install for mozdebug 07:58:30 INFO - Running setup.py install for mozdevice 07:58:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:58:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:58:31 INFO - Running setup.py install for mozfile 07:58:31 INFO - Running setup.py install for mozhttpd 07:58:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:58:31 INFO - Running setup.py install for mozinfo 07:58:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:58:31 INFO - Running setup.py install for mozInstall 07:58:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:58:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:58:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:58:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:58:31 INFO - Running setup.py install for mozleak 07:58:31 INFO - Running setup.py install for mozlog 07:58:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:58:31 INFO - Running setup.py install for moznetwork 07:58:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:58:31 INFO - Running setup.py install for mozprocess 07:58:31 INFO - Running setup.py install for mozprofile 07:58:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:58:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:58:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:58:32 INFO - Running setup.py install for mozrunner 07:58:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:58:32 INFO - Running setup.py install for mozscreenshot 07:58:32 INFO - Running setup.py install for moztest 07:58:32 INFO - Running setup.py install for mozversion 07:58:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:58:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:58:32 INFO - Cleaning up... 07:58:32 INFO - Return code: 0 07:58:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:32 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 0x1b32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df13b0>, '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 0x1df22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df2740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:58:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:58:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:58:32 INFO - Using env: {'DISPLAY': ':0', 07:58:32 INFO - 'HOME': '/home/cltbld', 07:58:32 INFO - 'LANG': 'en_US.UTF-8', 07:58:32 INFO - 'LANGUAGE': 'en_US:en', 07:58:32 INFO - 'LOGNAME': 'cltbld', 07:58:32 INFO - 'MAIL': '/var/mail/cltbld', 07:58:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:32 INFO - 'MOZ_NO_REMOTE': '1', 07:58:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:32 INFO - 'NO_EM_RESTART': '1', 07:58:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:32 INFO - 'PWD': '/builds/slave/test', 07:58:32 INFO - 'SHELL': '/bin/bash', 07:58:32 INFO - 'SHLVL': '1', 07:58:32 INFO - 'TERM': 'linux', 07:58:32 INFO - 'TMOUT': '86400', 07:58:32 INFO - 'USER': 'cltbld', 07:58:32 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795', 07:58:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:32 INFO - '_': '/tools/buildbot/bin/python'} 07:58:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:58:32 INFO - Running setup.py (path:/tmp/pip-QLzQP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:58:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:58:32 INFO - Running setup.py (path:/tmp/pip-mvF2R9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:58:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:58:32 INFO - Running setup.py (path:/tmp/pip-uAb6A4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:58:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:58:32 INFO - Running setup.py (path:/tmp/pip-e4cbvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:58:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:58:33 INFO - Running setup.py (path:/tmp/pip-wkqSwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:58:33 INFO - Running setup.py (path:/tmp/pip-yn1Ano-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:58:33 INFO - Running setup.py (path:/tmp/pip-ck5Z31-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:58:33 INFO - Running setup.py (path:/tmp/pip-2_mY0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:58:33 INFO - Running setup.py (path:/tmp/pip-qNY04e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:58:33 INFO - Running setup.py (path:/tmp/pip-vovTe0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:58:33 INFO - Running setup.py (path:/tmp/pip-0Hevl5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:58:33 INFO - Running setup.py (path:/tmp/pip-cinjLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:58:33 INFO - Running setup.py (path:/tmp/pip-x8mCMq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:58:33 INFO - Running setup.py (path:/tmp/pip-pHC0Nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:58:33 INFO - Running setup.py (path:/tmp/pip-ObDZTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:58:33 INFO - Running setup.py (path:/tmp/pip-xwGQO5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:58:33 INFO - Running setup.py (path:/tmp/pip-jojOvN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:58:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:35 INFO - Downloading blessings-1.6.tar.gz 07:58:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:58:35 INFO - Installing collected packages: blessings 07:58:35 INFO - Running setup.py install for blessings 07:58:36 INFO - Successfully installed blessings 07:58:36 INFO - Cleaning up... 07:58:36 INFO - Return code: 0 07:58:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:58:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:58:36 INFO - Reading from file tmpfile_stdout 07:58:36 INFO - Current package versions: 07:58:36 INFO - argparse == 1.2.1 07:58:36 INFO - blessings == 1.6 07:58:36 INFO - blobuploader == 1.2.4 07:58:36 INFO - docopt == 0.6.1 07:58:36 INFO - functools32 == 3.2.3-2 07:58:36 INFO - jsonschema == 2.5.1 07:58:36 INFO - manifestparser == 1.1 07:58:36 INFO - mozInstall == 1.12 07:58:36 INFO - mozcrash == 0.17 07:58:36 INFO - mozdebug == 0.1 07:58:36 INFO - mozdevice == 0.48 07:58:36 INFO - mozfile == 1.2 07:58:36 INFO - mozhttpd == 0.7 07:58:36 INFO - mozinfo == 0.9 07:58:36 INFO - mozleak == 0.1 07:58:36 INFO - mozlog == 3.2 07:58:36 INFO - moznetwork == 0.27 07:58:36 INFO - mozprocess == 0.22 07:58:36 INFO - mozprofile == 0.28 07:58:36 INFO - mozrunner == 6.11 07:58:36 INFO - mozscreenshot == 0.1 07:58:36 INFO - mozsystemmonitor == 0.3 07:58:36 INFO - moztest == 0.7 07:58:36 INFO - mozversion == 1.4 07:58:36 INFO - psutil == 3.1.1 07:58:36 INFO - requests == 1.2.3 07:58:36 INFO - wsgiref == 0.1.2 07:58:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:58:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:36 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 0x1b32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df13b0>, '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 0x1df22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df2740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:58:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:58:36 INFO - Using env: {'DISPLAY': ':0', 07:58:36 INFO - 'HOME': '/home/cltbld', 07:58:36 INFO - 'LANG': 'en_US.UTF-8', 07:58:36 INFO - 'LANGUAGE': 'en_US:en', 07:58:36 INFO - 'LOGNAME': 'cltbld', 07:58:36 INFO - 'MAIL': '/var/mail/cltbld', 07:58:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:36 INFO - 'MOZ_NO_REMOTE': '1', 07:58:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:36 INFO - 'NO_EM_RESTART': '1', 07:58:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:36 INFO - 'PWD': '/builds/slave/test', 07:58:36 INFO - 'SHELL': '/bin/bash', 07:58:36 INFO - 'SHLVL': '1', 07:58:36 INFO - 'TERM': 'linux', 07:58:36 INFO - 'TMOUT': '86400', 07:58:36 INFO - 'USER': 'cltbld', 07:58:36 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795', 07:58:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:36 INFO - '_': '/tools/buildbot/bin/python'} 07:58:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:58:36 INFO - Cleaning up... 07:58:36 INFO - Return code: 0 07:58:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:58:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:36 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 0x1b32030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c958a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1df3180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1df13b0>, '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 0x1df22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df2740>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:58:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:58:36 INFO - Using env: {'DISPLAY': ':0', 07:58:36 INFO - 'HOME': '/home/cltbld', 07:58:36 INFO - 'LANG': 'en_US.UTF-8', 07:58:36 INFO - 'LANGUAGE': 'en_US:en', 07:58:36 INFO - 'LOGNAME': 'cltbld', 07:58:36 INFO - 'MAIL': '/var/mail/cltbld', 07:58:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:36 INFO - 'MOZ_NO_REMOTE': '1', 07:58:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:36 INFO - 'NO_EM_RESTART': '1', 07:58:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:36 INFO - 'PWD': '/builds/slave/test', 07:58:36 INFO - 'SHELL': '/bin/bash', 07:58:36 INFO - 'SHLVL': '1', 07:58:36 INFO - 'TERM': 'linux', 07:58:36 INFO - 'TMOUT': '86400', 07:58:36 INFO - 'USER': 'cltbld', 07:58:36 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795', 07:58:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:36 INFO - '_': '/tools/buildbot/bin/python'} 07:58:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:58:36 INFO - Cleaning up... 07:58:36 INFO - Return code: 0 07:58:36 INFO - Running post-action listener: _resource_record_post_action 07:58:36 INFO - Running post-action listener: _start_resource_monitoring 07:58:36 INFO - Starting resource monitoring. 07:58:36 INFO - ##### 07:58:36 INFO - ##### Finished create-virtualenv step (success) 07:58:36 INFO - ##### 07:58:36 INFO - ##### 07:58:36 INFO - ##### Running install step. 07:58:36 INFO - ##### 07:58:36 INFO - Running pre-action listener: _resource_record_pre_action 07:58:36 INFO - Running main action method: install 07:58:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:58:36 INFO - Reading from file tmpfile_stdout 07:58:36 INFO - Detecting whether we're running mozinstall >=1.0... 07:58:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:58:37 INFO - Reading from file tmpfile_stdout 07:58:37 INFO - Output received: 07:58:37 INFO - Usage: mozinstall [options] installer 07:58:37 INFO - Options: 07:58:37 INFO - -h, --help show this help message and exit 07:58:37 INFO - -d DEST, --destination=DEST 07:58:37 INFO - Directory to install application into. [default: 07:58:37 INFO - "/builds/slave/test"] 07:58:37 INFO - --app=APP Application being installed. [default: firefox] 07:58:37 INFO - mkdir: /builds/slave/test/build/application 07:58:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:58:53 INFO - Reading from file tmpfile_stdout 07:58:53 INFO - Output received: 07:58:53 INFO - /builds/slave/test/build/application/firefox/firefox 07:58:53 INFO - Running post-action listener: _resource_record_post_action 07:58:53 INFO - ##### 07:58:53 INFO - ##### Finished install step (success) 07:58:53 INFO - ##### 07:58:53 INFO - ##### 07:58:53 INFO - ##### Running run-tests step. 07:58:53 INFO - ##### 07:58:53 INFO - Running pre-action listener: _resource_record_pre_action 07:58:53 INFO - Running main action method: run_tests 07:58:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:58:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:58:53 INFO - Python 2.7.3 07:58:53 INFO - Return code: 0 07:58:53 INFO - grabbing minidump binary from tooltool 07:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:53 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 0x1df13b0>, '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 0x1df22b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1df2740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:58:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:58:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:58:53 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:58:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:58:53 INFO - Return code: 0 07:58:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:58:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:58:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:58:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:58:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:58:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:58:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:58:53 INFO - Using env: {'DISPLAY': ':0', 07:58:53 INFO - 'HOME': '/home/cltbld', 07:58:53 INFO - 'LANG': 'en_US.UTF-8', 07:58:53 INFO - 'LANGUAGE': 'en_US:en', 07:58:53 INFO - 'LOGNAME': 'cltbld', 07:58:53 INFO - 'MAIL': '/var/mail/cltbld', 07:58:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:58:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:53 INFO - 'MOZ_NO_REMOTE': '1', 07:58:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:53 INFO - 'NO_EM_RESTART': '1', 07:58:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:53 INFO - 'PWD': '/builds/slave/test', 07:58:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:58:53 INFO - 'SHELL': '/bin/bash', 07:58:53 INFO - 'SHLVL': '1', 07:58:53 INFO - 'TERM': 'linux', 07:58:53 INFO - 'TMOUT': '86400', 07:58:53 INFO - 'USER': 'cltbld', 07:58:53 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795', 07:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:53 INFO - '_': '/tools/buildbot/bin/python'} 07:58:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:58:53 INFO - mozversion application_buildid: 20160701062824 07:58:53 INFO - mozversion application_changeset: 649dfb23aea44a0e98e2caf7f19691af92af64c4 07:58:53 INFO - mozversion application_display_name: Nightly 07:58:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:58:53 INFO - mozversion application_name: Firefox 07:58:53 INFO - mozversion application_remotingname: firefox 07:58:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:58:53 INFO - mozversion application_vendor: Mozilla 07:58:53 INFO - mozversion application_version: 50.0a1 07:58:53 INFO - mozversion platform_buildid: 20160701062824 07:58:53 INFO - mozversion platform_changeset: 649dfb23aea44a0e98e2caf7f19691af92af64c4 07:58:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:58:53 INFO - mozversion platform_version: 50.0a1 07:58:53 INFO - using testdate: 1467385133 07:58:53 INFO - actual date: 1467385133 07:58:53 INFO - starting webserver on 'localhost:36977' 07:58:53 INFO - SUITE-START | Running 2 tests 07:58:53 INFO - TEST-START | dromaeo_css 07:58:53 INFO - operating with platform_type : linux_ 07:58:53 INFO - Initialising browser for dromaeo_css test... 07:58:53 INFO - TEST-INFO | started process 13259 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2iDu9e/profile http://localhost:36977/getInfo.html) 07:58:57 INFO - PROCESS | 13259 | __metrics Screen width/height:1600/1200 07:58:57 INFO - PROCESS | 13259 | colorDepth:24 07:58:57 INFO - PROCESS | 13259 | Browser inner width/height: 1024/697 07:58:57 INFO - PROCESS | 13259 | __metrics 07:58:58 INFO - PROCESS | 13259 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:58:59 INFO - TEST-INFO | 13259: exit 0 07:58:59 INFO - Browser initialized. 07:58:59 INFO - Running cycle 1/1 for dromaeo_css test... 07:58:59 INFO - TEST-INFO | started process 13342 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2iDu9e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:59:11 INFO - PROCESS | 13342 | RSS: Main: 159199232 07:59:11 INFO - PROCESS | 13342 | 08:00:03 INFO - PROCESS | 13342 | 1467385203008 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:02:14 INFO - PROCESS | 13342 | Cycle 1(1): loaded http://localhost:36977/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36977/tests/dromaeo/cssquery-ext.html) 08:02:15 INFO - PROCESS | 13342 | RSS: Main: 274616320 08:02:15 INFO - PROCESS | 13342 | 08:05:18 INFO - PROCESS | 13342 | Cycle 1(1): loaded http://localhost:36977/tests/dromaeo/cssquery-ext.html (next: http://localhost:36977/tests/dromaeo/cssquery-jquery.html) 08:05:19 INFO - PROCESS | 13342 | RSS: Main: 241750016 08:05:19 INFO - PROCESS | 13342 | 08:08:21 INFO - PROCESS | 13342 | Cycle 1(1): loaded http://localhost:36977/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36977/tests/dromaeo/cssquery-mootools.html) 08:08:21 INFO - PROCESS | 13342 | RSS: Main: 237670400 08:08:21 INFO - PROCESS | 13342 | 08:11:23 INFO - PROCESS | 13342 | Cycle 1(1): loaded http://localhost:36977/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36977/tests/dromaeo/cssquery-prototype.html) 08:11:24 INFO - PROCESS | 13342 | RSS: Main: 231424000 08:11:24 INFO - PROCESS | 13342 | 08:14:27 INFO - PROCESS | 13342 | Cycle 1(1): loaded http://localhost:36977/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36977/tests/dromaeo/cssquery-yui.html) 08:14:28 INFO - PROCESS | 13342 | RSS: Main: 224903168 08:14:28 INFO - PROCESS | 13342 | 08:17:30 INFO - PROCESS | 13342 | Cycle 1(1): loaded http://localhost:36977/tests/dromaeo/cssquery-yui.html (next: http://localhost:36977/tests/dromaeo/cssquery-dojo.html) 08:17:31 INFO - PROCESS | 13342 | RSS: Main: 282062848 08:17:31 INFO - PROCESS | 13342 | 08:17:31 INFO - PROCESS | 13342 | __start_tp_report 08:17:31 INFO - PROCESS | 13342 | _x_x_mozilla_page_load 08:17:31 INFO - PROCESS | 13342 | _x_x_mozilla_page_load_details 08:17:31 INFO - PROCESS | 13342 | |i|pagename|runs| 08:17:31 INFO - PROCESS | 13342 | |0;dojo.html;2590.7927365810733;2609.9999999999995;2614.4901744159874;2648.814582979191;2656.89372425103;4526.841560545382;4598.885027874305;4702.200625893598;4705.106029854325;4726.102040612285;4650.837220697268;4694.812207511704;4702.741349225791;4722.079194557063;4727.267273572602;4087.4686290782156;4257.829686812532;4325.134973005396;4361.084172323815;4436.44544431946;4345.326474396474;4380.189664911985;4384.89037774055;4394.187075391047;4419.558044195571;4212.9789351053205;4235.9364609530885;4259.3610958356185;4277.315629499265;4286.057067445157;4225.2183346080765;4244.363345498169;4249.68127390447;4277.97861010696;4298.828046878121;4255;4262.211490874198;4294.312909934395;4300.22595932732;4301.763403012833;4569.702969306984;4644.419447569054;4661.953380466186;4705.3647757552635;4722.480527142012;5071.239314102877;5074.467180945984;5082.288479612857;5083.669561478492;5090.720010399426;5055.747212639353;5102;5114.820981265638;5120.871978200537;5132;4559.566841150052;4627.421572303462;4669.7431641260055;4670.322803193518;4734.857954261378;5155.097857874857;5173.042987047333;5173.275741396207;5175.146100893386;5178.0420622184265;4820.517948205152;4947.777350019258;4949.82675606352;4956.231784073474;4960.603151747851;4970.15507363749;5010.674306170087;5019.698818070854;5026.070177017264;5079.492050794891;4980.153373926441;4983.327250821165;4983.676061056092;4989.775460104304;5039.319691841628;4895.363602731622;4916.434610019822;4968.677035992721;4974.253861920669;4975.825846095369;4286.014216730107;4287.6355509782015;4287.807048682755;4316.050468896838;4334.913301733947;3723.3298006359114;3738.2336620992633;3754.9436758448646;3785.962140378616;3792.1088544192094;4222;4255.851045213402;4257.446531950826;4382.758948257876;4396.384506169139;4933.235348520985;5035.697858128524;5070.011347787146;5080.542751152414;5114.948850511447;4385.978070109629;4401.493828209733;4414.1171765647;4414.271645178574;4446.221911165598;4546.204414227563;4565.406497155349;4572.9314060289125;4577.908441831145;4627.930581041287;4619.976900115478;4683.718976861399;4738.8341408050555;4748.643851711066;4767.332573439721;4997.350344455198;5027.622928280467;5042.067217564762;5046.394432668103;5120.923186152285;4730.763461826964;4737.786799593958;4757.524247575215;4759.714417134983;4790.688605240648;4799.28010798383;4909.828156014665;4931.926021109614;4959.380077490314;4975.97992411562;5012.749362531786;5027.446980832178;5036.345275114211;5043.52086551777;5082.390113186441;4737.028909073701;4863.173260545786;4879.707217566957;4886.438059623189;4924.803007879788;4835.8065677372515;4880.097182021337;4915.582175514978;4938.259261110862;4971.428285747041;4844.806207751651;4849;4858.149823780895;4859.95140048595;4887.315775791463;4941.209406494943;4957.752112394438;4961.08219979305;4965.4289756677;4998.925016124688;4699.130660827758;4772.141014617402;4821.975890120527;4822.541858523435;4834.081524510332 08:17:31 INFO - PROCESS | 13342 | |1;ext.html;555.3252797850612;557.5539568345325;562.5640128900104;567.4042255631585;575.7178982298673;27324.86337568312;27780;30032.399352012948;30032.69967300329;30099.09702708922;30159.84920075402;43927.78036109815;45207.547924520746;45551.77224113875;45631.77184114075;7792.961035194816;7910.169432209622;7911.2088791121005;7915.643796029192;7919.287264146225;7754.302112809846;7856.292933635971;7862.01724784402;7863.724769633064;7873.763787086368;7754.922450775504;7782.416318776086;7783.844323113534;7784;7788.4937479063965;7868.213178682115;7910.683572657087;7924.524528528249;7929.96035019827;7940.563269020202;7808.804779880492;7822.295993360625;7850.803729906741;7869.291763741291;7869.724559640385;38571;38930.80534597337;38992.80503597464;38997.61002389968;39014.609853901384;3128.562001319817;3174.3175217328153;3206.118317462693;3248.6751324867323;3395.6434574369828;29107.708922910922;29566.556501652492;29881.727734047177;30394.84802575995;30988.38023239545;3055.159831046458;3299.7360211183286;3330.933381332384;3344.4816053511745;3375.088726043979;201962;258313;260256;260529;261816;27322.726772732018;56507.43492565022;57242;57295.713521432124;57310.994115205765;28352.43295134086;29884.402311954073;29891;29891.551626725617;29948.40103197924;13300.600981970556;13480.662983425493;13535.59393218205;13563.05058645905;13583.185008899498;11288.887111128948;11367.09063274936;11377.715557111138;11377.943110284396;11385.658430247106;7960.2039796019935;7987.56068416231;8018.599070046591;8091.39314551411;8112.472689275178;3139.7802153849466;3176.1097401364646;3184.1402821238134;3196.1370429983776;3230.3054843208824;884.5356188001222;891.5542228885557;897.9102089791099;907.6233363154349;1017.893121222261;27625.86187069092;28291.85046206651;28468.145955621363;28956.828237881822;29341.359277665113;945.3524335829978;963.4219468319093;978.0610613810821;1006.3106771861299;1033.6278939581744;14823.77764333536;15185.468508602145;15302.770458443132;15314.157721325211;15378.461753838563;409537;468906;712646;714543;727478;49972.50027499751;50530.49469505331;50685.49314506882;50691;50774.49225507698;1071.052118874786;1161.5992482593492;1201.1531870031606;1209.6975756060986;1220.9389530523615;25771.871140644176;29474.410511789214;29539.85230073836;29997.400051999273;30008.24979375533;41503.58496415118;42053.579464204966;42179.945501361486;42199.367009495494;42233.57766422296;312462;319181;319676;320011;321358;22928;25406.872965635794;25579.87210064012;25618;25994.61008084918;40793.184136316515;41071.38392924049;41186;41460;42438.5756142447;34863;35471.82264088663;35790.821045894605;35896;36327.27345453129;36214;36415.27169456649;36426.27147457089;36766;37131.814340928126;35645;35655.64344356627;37079.6292037087;37812.81093594514;37857.2428551433;30833.845830770704;33543.47567503282;33620.1594960128;34065;34094.31811363709;25746.742532575183;25949.091781787545;25958.610620840325;26117.608235876098;26395 08:17:31 INFO - PROCESS | 13342 | |2;jquery.html;368.48964184604324;368.7142464589942;374.52622432622735;384.2085304273197;389.81094169327855;16250.83749162508;17378.13109344534;17966.730499042525;18211.544711382223;18263.17815698295;16667.91666041671;17228.82771172288;17279.222434990425;17492.562685932826;17499.037552934584;5239.816606418766;5390.5418039466695;5430.809921652743;5433.076377015897;5433.347998240217;3882.456456096149;3932.9016774580577;5298.602604804636;6329.841753956165;6447.226332840066;6310.968445157768;6345.270293916189;6349.650769207692;6374.904376434334;6379.904301435482;6134.631922084689;6141.447269745744;6164.167837341946;6310.179676642053;6311.936880631227;5414.566834653218;5516.531094856942;5558.416366281523;5564.1931919871795;5567.8608034799045;20606.27878024262;21073.26243581467;21117.366479005654;21380.89309553458;21931.780682193134;1739.7564340992271;1998.8500862435376;2090.4669309326177;2187.704659870913;2334.6031174700342;9554.61781528738;9691.51542422876;9807.803843923153;9819;9884.851727224097;1769.9911500442415;1843.5298998755231;1847.7597912271453;1852.3609354772582;1855.4526414707693;68519.31480685179;69559.99999999949;69735.65132174306;69755.65122174408;70077.64961175213;10074.639923610219;10176.898231017743;10315.226358023028;10412.895871041344;10528;14036.087654302437;14065.015448918477;14142.434302627986;14179.574612761427;14186.219757913414;7159.463040272;7468.589227592534;7577.158565537923;7649.502782319131;7656.808579785438;7192.604406757574;7195.748148814766;7357.963210183915;7364.926350736424;7420.962895185489;4321.222180007629;4404.2512772828695;4469.508354081048;4509;4565.817367305271;1789.329001624391;1839.6596629623562;1898.4399602117132;1911.2832687742098;1937.457511896643;779.174075479993;898.23201163006;912.6440688131634;952.9809403811885;971.7667759737612;16560.254788534545;17245.827541724422;17388.65222695539;17717.11414429299;17745.201465934064;848.2154007542998;857.3484152044491;864.984585914817;871.0810095349341;931.4830269200659;9404.429240545383;9851.50742462874;9852.605895764089;9854.11312981835;9867.210623150131;395266;398385;398912;418617;424242;65841;82352.58823705843;88206;89910;91160.54419727859;889.7997950461095;938.9201917837061;946.5645802930729;988.3081842710131;991.4150651115876;13920.164790112625;15404;16136.757948631015;16343.509694709177;16598.41905533349;37290.44064339092;37687;37822.81088594539;38513.80743096267;38605;54345.72827135839;54913;56417.43582564286;56466.71766641141;57098.14352784795;7613.581253030915;7658.119316278699;7877.881831772643;7944.126146124037;8040.437169398086;10382.42896640692;11663.825042624538;11678.474468649101;11709.824352634547;11858.525658973544;10006.69979900604;10159.187265018929;10328.431936243578;10384.26644324266;10453.790924181625;9490.525473726148;10318;10418.947905260426;10772.730681732706;10779.622713205;9585.472798996123;9690.224782017282;9926.10665040121;10237.283390162616;10419.479026048819;7335.816604584715;7835.168329424967;7914.287714105758;7924.48490848093;7998.560079195468;7874;9199.632014719336;10141.188704903738;10475.94762026185;10794.946025269823 08:17:31 INFO - PROCESS | 13342 | |3;mootools.html;1377.9448822047123;1423.672555312278;1466.8386477487481;1652.5042487253813;1657.8010638723356;7356.301151390616;7804.219578042207;7845.529268243909;7845.725399611015;7850.254225848543;6935.687894044768;7466;7686.077670679512;7784.494007889483;7791.805204869881;2176.1513009926143;2211.281333566589;2211.4139752965475;2212.23677831148;2214.2914267434426;2142.9464263393384;2188.485705859122;2202.735671719396;2203.636399993999;2208.4810069633622;1917.405604262676;2102.8317734581196;2162.19998600518;2171.6742488626674;2198.0218802632835;2162.416147640144;2168.9240876569324;2192.9780702193093;2193.6928829963817;2213.0262684418803;2207.9448013799624;2215.2578886073184;2215.7562668106493;2216.8337374696803;2217.9001944912357;8038.356931445471;8044;8046.839063218761;8047.47691400063;8049.798755031113;4404.977975110104;4499.595036446735;4525.2533332000185;4549.727016379028;4554.726716397026;2809.4240680660414;2833.4191490744347;2929.311611771232;2931.5456104303867;2938.0598208573265;893.7765558610347;917.4862077236769;922.547951503765;936.2884208001899;936.4100616611491;10371;10372.118369938564;10394.9480252599;10405.167586593054;10427.791444171075;4068.3694027425795;4176.791160441966;4343.543927887589;4351.717138385995;4356.520782713899;8821.647134114692;8853.335999800041;8892.421992570462;8897.466152030898;8901.910980890238;4648.395708557866;4654.488006319302;4655.837045703384;4656.231721765871;4658.254679251304;4167.74993500391;4219.831206751695;4237.957620423756;4238.237117318912;4240.872773816791;3733.4213196954515;3780.243951209769;3810.8856734298015;3856.6914646828186;3860.942085868714;1070.1224995503612;1183.1185766603762;1197.4192516629428;1205.5358686905604;1213.6298428979246;619.9225096862892;775.143466469543;849.5285116760134;868.5961028121827;871.7689812199773;5135.563477104488;5306.389765177054;5367.624266301322;5398.784048638089;5458;882.2280504558511;896.1486587741672;904.4754042655244;905.2034209895381;912.2063804490136;3591.856325746941;3645.343838109166;3651.087228192952;3682.9815850920572;3698.981505092457;9631.759206019906;9910.752231194278;9950.55222514974;10102.69691909244;10107.7473063174;9751.951240243754;10043.748906277402;10054.09513143806;10058.195344372432;10058.497075146213;7435.4795164337975;7443.069616297963;7540.509866858637;7556.24437556251;7623.656935437919;5250.579953603627;5257.763400647056;5258.395284542174;5300;5312.043832110257;9120.589573469077;9134.771630709285;9183.127602877716;9356.204722598382;9403.059694030542;9135.949365823015;9466.668666596635;9488.383255088396;9523.52382380892;9564.330496865152;6745.460363170836;6986.860262794614;7007.089078419976;7033.226345102137;7069.399101076466;7893.763187104396;7909.288164065261;7962.08436029864;7969.521828690297;7974.122846486998;6653.5009874260595;6870.381665650116;6885.4835887309655;6995.720171193096;7127.287271272831;6580.638064906476;6641.302663220486;6766.018927255619;6990.755323563651;7065.540739851893;6192.318844927145;6201.069839524108;6232.002879539252;6281.748730050746;6301.873962520633;4330.566943305645;4396.34054891756;4422.226110430597;4439.445069366329;4487.304467807495;4597.862064138081;4618.722876627413;4652.255639097728;4711.787969541448;4746.33551302811 08:17:31 INFO - PROCESS | 13342 | |4;prototype.html;286.3185618228617;299.20859327079876;303.7645824486024;305.4486651593872;308.42940559964063;4558;4758.571728544431;4783.736894470802;4807.23084306511;4817.9277310840325;4575.428071491064;4723.90552188956;4736.952630473695;4743.976280118603;4759.881002974918;3729.608391118934;3740.2706472237924;3742.719296052807;3745.119896824258;3746.2132952080096;3572.4819901114324;3615.9638403616023;3748.269087527933;3750.624937506241;3759.624037596232;3704.38859096294;3715.420946097911;3721.79530125843;3736.794476303802;3742.419924911643;3714.182879766447;3715.5541335039698;3716.3682174030478;3729.962700372989;3739.364308067608;3298.367308182465;3298.422776014188;3300.141963089614;3302.6367099619024;3313.122022663996;4453.688241823073;4638.281066434708;4645.907081858378;4668.4594083952215;4668.976655116737;4251.766152861592;4260.616544511009;4261.595148460891;4271.594198551133;4284;4781.282807578891;4968.826091086795;4977.800887964477;4979.775910084055;4982.7259500727805;3554.2713743682484;3588.9282214355567;3590.2281009583066;3590.35373632746;3591.44332628443;5171.689698618095;5202.973985130088;5224.320838290998;5225.477452254782;5229.660072095339;3636.4181730922924;3645.85416583339;3648.9817550912076;3657.3416784978426;3661.5972243053243;3564.2336897567147;3644.3075815594952;3703.7222208334483;3709.7588656737225;3732.4774531565604;4164.083901541656;4226.725262857904;4232.30167022444;4234.047339348622;4237.470316210473;5003.799848006039;5011.6241281904;5013.849584512471;5015;5022.192010876081;1184.8045072562932;1229.4467489629524;1271.2753730373784;1274.5602767045355;1277.514544473113;833.1377024779324;848.3891598049395;856.498948115347;861.7500924731883;863.3826813828143;4437.667174961891;4437.667174961891;4440.800163992628;4441.933370999438;4456.977715111404;5124.56441202502;5128.974355128201;5136.280920671109;5140.922886156711;5142.151544995034;4418.668599855024;4424.778761061934;4429.202743506135;4429.446319210098;4431.357453169272;2602.6746656667915;2753.7934654900964;2755.7106503817213;2756.724327567227;2758.544840101401;4855.6115510759055;4857.927131093036;4865.5620994109995;4868.586170175575;4879.1461494238365;5018.84943451697;5296.443873393316;5300.522952934254;5301.469853014745;5303.655262407931;4855.5387238212315;4879.194932836042;4888.780004899717;4891.828785992473;4902.142125128088;5186.769689033752;5190.97404512975;5193.896122077613;5202.687838729688;5207.453217412269;4762.904741905073;5073.260439362851;5088;5116.027954688598;5129.307543481582;4831.202851529459;4836.863337115705;4840.177169881199;4845.200541910545;4892.779824907817;3647.5258216431694;3655.360311945452;3680.6871415928877;3689.4465830125696;3690.1512652090705;5005.5745261653165;5184.9740751296;5187.844364669066;5193.8836697980905;5204.9739751301;5041.747912604282;5056;5058.898822023612;5060.1903695408555;5066.328111723049;5011.974940125276;5037.798488060436;5046.29351890743;5047.217681259411;5048.217526283432;4847.442544107473;4969.130402179677;4981.850544483671;4984.40187177541;4993.776524751459;5031.6729412588065;5060.671056381323;5065.670731402447;5065.797368105234;5075.847724568269;4961.6030717543235;4970.826021089245;4975.353204083591;4981.4769449207315;4997.875053123701 08:17:31 INFO - PROCESS | 13342 | |5;yui.html;678.8642271545692;680.9829754256144;688.1570076656097;717.3328804212081;741.5128052412151;12590.685232869182;13735.939609058647;13780.862191378108;13863.722725545496;13880.16718996861;12339.259644421341;12420;13754.312284385791;13781.724365512684;13796.241206733626;780.4965797060893;789.4158322841114;795.3796039089519;796.625585974594;796.7928338631968;635.9268684101318;778.6534991928594;802.0575823407502;810.4084018666377;814.1288820961573;849.1169184048582;849.2484151525882;851.0808327006848;851.5784686580151;851.9787005324855;657.5265808617787;844.8268105038452;846.3525403066659;846.7840700621364;847.1401527449643;590.8345663214307;600.7536909866934;609.7591451376682;609.8170548835376;609.9664518451483;13441.126326788728;13521.526746563823;13532.59402217935;13547.864521354759;13564.864351356458;12078.516859325617;12336.321502317369;12484.625461236177;12620.432080556306;12803.679908002281;10913.23607347478;11025;11317.377544235063;11684.474198660995;12054.69863253417;4131.607497287753;4132.2561938850995;4141.855035073758;4204.621584057419;4241.406203131564;60322.39677603212;61443.385566144214;61777;62864.685676571324;63046.0543091854;10277.075063244343;10326.380417174994;10396.272260941812;10464.63373781914;10480.318779279323;19130.52173695641;19134;19194.904025480064;19208.327708530414;19211.135498902582;6731.831704207434;6769.559978601474;6808.217055038734;6888.862222755517;7112.395446387115;3744.8876533704033;3746.7189960753053;3783.5270591176104;3807.124361396894;3852.7110466715108;2780.569011803174;2877.5971364009056;2880.495913215179;2881.4957382457987;2882.553204253344;500.52950226786703;501.38079471852234;508.2503307621229;508.77613849905924;512.18562485648;529.8940211957624;539.3500831498036;553.3000754046135;554.7420449491007;561.4750208555014;7474;7680.231976802387;7703.229677032252;8015.639296231683;8041.914341563931;528.3448523830499;534.2627174499244;546.7703564502918;554.4621716934568;555.9714528123021;3687.483752274684;3726.7701658452647;3837.6737977271687;3897.395903634941;3908.863189788344;53925.460745392826;53985;54019.45980540223;55896;79938;83578;84258.57870710608;85581;86051;86470.56764716136;41419.792901035304;41507.377389339184;46089.30866037012;52891;70581.2941870585;6646.90029649546;6993.440524758109;7173.1392232932385;7180.210176880434;7258.165310989304;43239.135217296105;43431.34852977144;44176.55823441724;44303;45491.772541137085;57841.42158578528;60114.699426502586;60373;60596.697016514634;60599.69700151471;9495.715128546155;9549.713508594754;9667.806643866943;9674.419534827934;9825.55784989663;10509.31689440184;10639.468026598794;10675.946620266848;10716;10748.623798167027;9587.712368628952;9755.512224388895;9784.461854597781;9857;9858.55636496345;9271.536423178679;9359.812803743751;9604.183644390305;9682.179285263783;9698.660546880825;9505.28710346713;9661.447081551638;9691.563879625293;9777.467666774595;9970.451625160686;8252;8375.74088487104;8390;8524.488530688179;8609.096044915445;7909.24862138096;8238.176182381714;8310.293625041939;8500.234978851686;8532.786680333042 08:17:31 INFO - PROCESS | 13342 | __end_tp_report 08:17:31 INFO - PROCESS | 13342 | __start_cc_report 08:17:31 INFO - PROCESS | 13342 | _x_x_mozilla_cycle_collect,1074 08:17:31 INFO - PROCESS | 13342 | __end_cc_report 08:17:31 INFO - PROCESS | 13342 | __startTimestamp1467386251114__endTimestamp 08:17:31 INFO - PROCESS | 13342 | 08:17:31 INFO - PROCESS | 13342 | ------- Summary: start ------- 08:17:31 INFO - PROCESS | 13342 | Number of tests: 6 08:17:31 INFO - PROCESS | 13342 | 08:17:31 INFO - PROCESS | 13342 | [#0] dojo.html Cycles:165 Average:4644.30 Median:4748.64 stddev:488.31 (10.3%) stddev-sans-first:462.47 08:17:31 INFO - PROCESS | 13342 | Values: 2590.8 2610.0 2614.5 2648.8 2656.9 4526.8 4598.9 4702.2 4705.1 4726.1 4650.8 4694.8 4702.7 4722.1 4727.3 4087.5 4257.8 4325.1 4361.1 4436.4 4345.3 4380.2 4384.9 4394.2 4419.6 4213.0 4235.9 4259.4 4277.3 4286.1 4225.2 4244.4 4249.7 4278.0 4298.8 4255.0 4262.2 4294.3 4300.2 4301.8 4569.7 4644.4 4662.0 4705.4 4722.5 5071.2 5074.5 5082.3 5083.7 5090.7 5055.7 5102.0 5114.8 5120.9 5132.0 4559.6 4627.4 4669.7 4670.3 4734.9 5155.1 5173.0 5173.3 5175.1 5178.0 4820.5 4947.8 4949.8 4956.2 4960.6 4970.2 5010.7 5019.7 5026.1 5079.5 4980.2 4983.3 4983.7 4989.8 5039.3 4895.4 4916.4 4968.7 4974.3 4975.8 4286.0 4287.6 4287.8 4316.1 4334.9 3723.3 3738.2 3754.9 3786.0 3792.1 4222.0 4255.9 4257.4 4382.8 4396.4 4933.2 5035.7 5070.0 5080.5 5114.9 4386.0 4401.5 4414.1 4414.3 4446.2 4546.2 4565.4 4572.9 4577.9 4627.9 4620.0 4683.7 4738.8 4748.6 4767.3 4997.4 5027.6 5042.1 5046.4 5120.9 4730.8 4737.8 4757.5 4759.7 4790.7 4799.3 4909.8 4931.9 4959.4 4976.0 5012.7 5027.4 5036.3 5043.5 5082.4 4737.0 4863.2 4879.7 4886.4 4924.8 4835.8 4880.1 4915.6 4938.3 4971.4 4844.8 4849.0 4858.1 4860.0 4887.3 4941.2 4957.8 4961.1 4965.4 4998.9 4699.1 4772.1 4822.0 4822.5 4834.1 08:17:31 INFO - PROCESS | 13342 | 08:17:31 INFO - PROCESS | 13342 | [#1] ext.html Cycles:180 Average:52224.69 Median:35167.41 stddev:115356.59 (328.0%) stddev-sans-first:115614.96 08:17:31 INFO - PROCESS | 13342 | Values: 555.3 557.6 562.6 567.4 575.7 27324.9 27780.0 30032.4 30032.7 30099.1 30159.8 43927.8 45207.5 45551.8 45631.8 7793.0 7910.2 7911.2 7915.6 7919.3 7754.3 7856.3 7862.0 7863.7 7873.8 7754.9 7782.4 7783.8 7784.0 7788.5 7868.2 7910.7 7924.5 7930.0 7940.6 7808.8 7822.3 7850.8 7869.3 7869.7 38571.0 38930.8 38992.8 38997.6 39014.6 3128.6 3174.3 3206.1 3248.7 3395.6 29107.7 29566.6 29881.7 30394.8 30988.4 3055.2 3299.7 3330.9 3344.5 3375.1 201962.0 258313.0 260256.0 260529.0 261816.0 27322.7 56507.4 57242.0 57295.7 57311.0 28352.4 29884.4 29891.0 29891.6 29948.4 13300.6 13480.7 13535.6 13563.1 13583.2 11288.9 11367.1 11377.7 11377.9 11385.7 7960.2 7987.6 8018.6 8091.4 8112.5 3139.8 3176.1 3184.1 3196.1 3230.3 884.5 891.6 897.9 907.6 1017.9 27625.9 28291.9 28468.1 28956.8 29341.4 945.4 963.4 978.1 1006.3 1033.6 14823.8 15185.5 15302.8 15314.2 15378.5 409537.0 468906.0 712646.0 714543.0 727478.0 49972.5 50530.5 50685.5 50691.0 50774.5 1071.1 1161.6 1201.2 1209.7 1220.9 25771.9 29474.4 29539.9 29997.4 30008.2 41503.6 42053.6 42179.9 42199.4 42233.6 312462.0 319181.0 319676.0 320011.0 321358.0 22928.0 25406.9 25579.9 25618.0 25994.6 40793.2 41071.4 41186.0 41460.0 42438.6 34863.0 35471.8 35790.8 35896.0 36327.3 36214.0 36415.3 36426.3 36766.0 37131.8 35645.0 35655.6 37079.6 37812.8 37857.2 30833.8 33543.5 33620.2 34065.0 34094.3 25746.7 25949.1 25958.6 26117.6 26395.0 08:17:31 INFO - PROCESS | 13342 | 08:17:31 INFO - PROCESS | 13342 | [#2] jquery.html Cycles:180 Average:25309.48 Median:4902.82 stddev:67337.31 (1373.4%) stddev-sans-first:67500.16 08:17:31 INFO - PROCESS | 13342 | Values: 368.5 368.7 374.5 384.2 389.8 16250.8 17378.1 17966.7 18211.5 18263.2 16667.9 17228.8 17279.2 17492.6 17499.0 5239.8 5390.5 5430.8 5433.1 5433.3 3882.5 3932.9 5298.6 6329.8 6447.2 6311.0 6345.3 6349.7 6374.9 6379.9 6134.6 6141.4 6164.2 6310.2 6311.9 5414.6 5516.5 5558.4 5564.2 5567.9 20606.3 21073.3 21117.4 21380.9 21931.8 1739.8 1998.9 2090.5 2187.7 2334.6 9554.6 9691.5 9807.8 9819.0 9884.9 1770.0 1843.5 1847.8 1852.4 1855.5 68519.3 69560.0 69735.7 69755.7 70077.6 10074.6 10176.9 10315.2 10412.9 10528.0 14036.1 14065.0 14142.4 14179.6 14186.2 7159.5 7468.6 7577.2 7649.5 7656.8 7192.6 7195.7 7358.0 7364.9 7421.0 4321.2 4404.3 4469.5 4509.0 4565.8 1789.3 1839.7 1898.4 1911.3 1937.5 779.2 898.2 912.6 953.0 971.8 16560.3 17245.8 17388.7 17717.1 17745.2 848.2 857.3 865.0 871.1 931.5 9404.4 9851.5 9852.6 9854.1 9867.2 395266.0 398385.0 398912.0 418617.0 424242.0 65841.0 82352.6 88206.0 89910.0 91160.5 889.8 938.9 946.6 988.3 991.4 13920.2 15404.0 16136.8 16343.5 16598.4 37290.4 37687.0 37822.8 38513.8 38605.0 54345.7 54913.0 56417.4 56466.7 57098.1 7613.6 7658.1 7877.9 7944.1 8040.4 10382.4 11663.8 11678.5 11709.8 11858.5 10006.7 10159.2 10328.4 10384.3 10453.8 9490.5 10318.0 10418.9 10772.7 10779.6 9585.5 9690.2 9926.1 10237.3 10419.5 7335.8 7835.2 7914.3 7924.5 7998.6 7874.0 9199.6 10141.2 10475.9 10794.9 08:17:31 INFO - PROCESS | 13342 | 08:17:31 INFO - PROCESS | 13342 | [#3] mootools.html Cycles:180 Average:5207.74 Median:4940.95 stddev:2932.80 (59.4%) stddev-sans-first:2926.90 08:17:31 INFO - PROCESS | 13342 | Values: 1377.9 1423.7 1466.8 1652.5 1657.8 7356.3 7804.2 7845.5 7845.7 7850.3 6935.7 7466.0 7686.1 7784.5 7791.8 2176.2 2211.3 2211.4 2212.2 2214.3 2142.9 2188.5 2202.7 2203.6 2208.5 1917.4 2102.8 2162.2 2171.7 2198.0 2162.4 2168.9 2193.0 2193.7 2213.0 2207.9 2215.3 2215.8 2216.8 2217.9 8038.4 8044.0 8046.8 8047.5 8049.8 4405.0 4499.6 4525.3 4549.7 4554.7 2809.4 2833.4 2929.3 2931.5 2938.1 893.8 917.5 922.5 936.3 936.4 10371.0 10372.1 10394.9 10405.2 10427.8 4068.4 4176.8 4343.5 4351.7 4356.5 8821.6 8853.3 8892.4 8897.5 8901.9 4648.4 4654.5 4655.8 4656.2 4658.3 4167.7 4219.8 4238.0 4238.2 4240.9 3733.4 3780.2 3810.9 3856.7 3860.9 1070.1 1183.1 1197.4 1205.5 1213.6 619.9 775.1 849.5 868.6 871.8 5135.6 5306.4 5367.6 5398.8 5458.0 882.2 896.1 904.5 905.2 912.2 3591.9 3645.3 3651.1 3683.0 3699.0 9631.8 9910.8 9950.6 10102.7 10107.7 9752.0 10043.7 10054.1 10058.2 10058.5 7435.5 7443.1 7540.5 7556.2 7623.7 5250.6 5257.8 5258.4 5300.0 5312.0 9120.6 9134.8 9183.1 9356.2 9403.1 9135.9 9466.7 9488.4 9523.5 9564.3 6745.5 6986.9 7007.1 7033.2 7069.4 7893.8 7909.3 7962.1 7969.5 7974.1 6653.5 6870.4 6885.5 6995.7 7127.3 6580.6 6641.3 6766.0 6990.8 7065.5 6192.3 6201.1 6232.0 6281.7 6301.9 4330.6 4396.3 4422.2 4439.4 4487.3 4597.9 4618.7 4652.3 4711.8 4746.3 08:17:31 INFO - PROCESS | 13342 | 08:17:31 INFO - PROCESS | 13342 | [#4] prototype.html Cycles:180 Average:4164.39 Median:4759.23 stddev:1212.49 (25.5%) stddev-sans-first:1180.44 08:17:31 INFO - PROCESS | 13342 | Values: 286.3 299.2 303.8 305.4 308.4 4558.0 4758.6 4783.7 4807.2 4817.9 4575.4 4723.9 4737.0 4744.0 4759.9 3729.6 3740.3 3742.7 3745.1 3746.2 3572.5 3616.0 3748.3 3750.6 3759.6 3704.4 3715.4 3721.8 3736.8 3742.4 3714.2 3715.6 3716.4 3730.0 3739.4 3298.4 3298.4 3300.1 3302.6 3313.1 4453.7 4638.3 4645.9 4668.5 4669.0 4251.8 4260.6 4261.6 4271.6 4284.0 4781.3 4968.8 4977.8 4979.8 4982.7 3554.3 3588.9 3590.2 3590.4 3591.4 5171.7 5203.0 5224.3 5225.5 5229.7 3636.4 3645.9 3649.0 3657.3 3661.6 3564.2 3644.3 3703.7 3709.8 3732.5 4164.1 4226.7 4232.3 4234.0 4237.5 5003.8 5011.6 5013.8 5015.0 5022.2 1184.8 1229.4 1271.3 1274.6 1277.5 833.1 848.4 856.5 861.8 863.4 4437.7 4437.7 4440.8 4441.9 4457.0 5124.6 5129.0 5136.3 5140.9 5142.2 4418.7 4424.8 4429.2 4429.4 4431.4 2602.7 2753.8 2755.7 2756.7 2758.5 4855.6 4857.9 4865.6 4868.6 4879.1 5018.8 5296.4 5300.5 5301.5 5303.7 4855.5 4879.2 4888.8 4891.8 4902.1 5186.8 5191.0 5193.9 5202.7 5207.5 4762.9 5073.3 5088.0 5116.0 5129.3 4831.2 4836.9 4840.2 4845.2 4892.8 3647.5 3655.4 3680.7 3689.4 3690.2 5005.6 5185.0 5187.8 5193.9 5205.0 5041.7 5056.0 5058.9 5060.2 5066.3 5012.0 5037.8 5046.3 5047.2 5048.2 4847.4 4969.1 4981.9 4984.4 4993.8 5031.7 5060.7 5065.7 5065.8 5075.8 4961.6 4970.8 4975.4 4981.5 4997.9 08:17:31 INFO - PROCESS | 13342 | 08:17:31 INFO - PROCESS | 13342 | [#5] yui.html Cycles:180 Average:15649.75 Median:30357.73 stddev:21322.77 (70.2%) stddev-sans-first:21352.96 08:17:31 INFO - PROCESS | 13342 | Values: 678.9 681.0 688.2 717.3 741.5 12590.7 13735.9 13780.9 13863.7 13880.2 12339.3 12420.0 13754.3 13781.7 13796.2 780.5 789.4 795.4 796.6 796.8 635.9 778.7 802.1 810.4 814.1 849.1 849.2 851.1 851.6 852.0 657.5 844.8 846.4 846.8 847.1 590.8 600.8 609.8 609.8 610.0 13441.1 13521.5 13532.6 13547.9 13564.9 12078.5 12336.3 12484.6 12620.4 12803.7 10913.2 11025.0 11317.4 11684.5 12054.7 4131.6 4132.3 4141.9 4204.6 4241.4 60322.4 61443.4 61777.0 62864.7 63046.1 10277.1 10326.4 10396.3 10464.6 10480.3 19130.5 19134.0 19194.9 19208.3 19211.1 6731.8 6769.6 6808.2 6888.9 7112.4 3744.9 3746.7 3783.5 3807.1 3852.7 2780.6 2877.6 2880.5 2881.5 2882.6 500.5 501.4 508.3 508.8 512.2 529.9 539.4 553.3 554.7 561.5 7474.0 7680.2 7703.2 8015.6 8041.9 528.3 534.3 546.8 554.5 556.0 3687.5 3726.8 3837.7 3897.4 3908.9 53925.5 53985.0 54019.5 55896.0 79938.0 83578.0 84258.6 85581.0 86051.0 86470.6 41419.8 41507.4 46089.3 52891.0 70581.3 6646.9 6993.4 7173.1 7180.2 7258.2 43239.1 43431.3 44176.6 44303.0 45491.8 57841.4 60114.7 60373.0 60596.7 60599.7 9495.7 9549.7 9667.8 9674.4 9825.6 10509.3 10639.5 10675.9 10716.0 10748.6 9587.7 9755.5 9784.5 9857.0 9858.6 9271.5 9359.8 9604.2 9682.2 9698.7 9505.3 9661.4 9691.6 9777.5 9970.5 8252.0 8375.7 8390.0 8524.5 8609.1 7909.2 8238.2 8310.3 8500.2 8532.8 08:17:31 INFO - PROCESS | 13342 | -------- Summary: end -------- 08:17:31 INFO - PROCESS | 13342 | 08:17:31 INFO - TEST-INFO | 13342: exit 0 08:17:31 INFO - TEST-OK | dromaeo_css | took 1118332ms 08:17:31 INFO - TEST-START | kraken 08:17:31 INFO - operating with platform_type : linux_ 08:17:31 INFO - Initialising browser for kraken test... 08:17:31 INFO - TEST-INFO | started process 13540 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppEE21T/profile http://localhost:36977/getInfo.html) 08:17:36 INFO - PROCESS | 13540 | __metrics Screen width/height:1600/1200 08:17:36 INFO - PROCESS | 13540 | colorDepth:24 08:17:36 INFO - PROCESS | 13540 | Browser inner width/height: 1024/697 08:17:36 INFO - PROCESS | 13540 | __metrics 08:17:36 INFO - PROCESS | 13540 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:17:37 INFO - TEST-INFO | 13540: exit 0 08:17:37 INFO - Browser initialized. 08:17:37 INFO - Running cycle 1/1 for kraken test... 08:17:37 INFO - TEST-INFO | started process 13620 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppEE21T/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:17:49 INFO - PROCESS | 13620 | RSS: Main: 159072256 08:17:49 INFO - PROCESS | 13620 | 08:17:52 INFO - PROCESS | 13620 | Cycle 1(1): loaded http://localhost:36977/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36977/tests/kraken/driver.html?testName=audio-beat-detection) 08:17:53 INFO - PROCESS | 13620 | RSS: Main: 215810048 08:17:53 INFO - PROCESS | 13620 | 08:17:56 INFO - PROCESS | 13620 | Cycle 1(1): loaded http://localhost:36977/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36977/tests/kraken/driver.html?testName=audio-dft) 08:17:56 INFO - PROCESS | 13620 | RSS: Main: 203845632 08:17:56 INFO - PROCESS | 13620 | 08:18:00 INFO - PROCESS | 13620 | Cycle 1(1): loaded http://localhost:36977/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36977/tests/kraken/driver.html?testName=audio-fft) 08:18:00 INFO - PROCESS | 13620 | RSS: Main: 271159296 08:18:00 INFO - PROCESS | 13620 | 08:18:02 INFO - PROCESS | 13620 | Cycle 1(1): loaded http://localhost:36977/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36977/tests/kraken/driver.html?testName=audio-oscillator) 08:18:03 INFO - PROCESS | 13620 | RSS: Main: 181125120 08:18:03 INFO - PROCESS | 13620 | 08:18:05 INFO - PROCESS | 13620 | Cycle 1(1): loaded http://localhost:36977/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36977/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:18:06 INFO - PROCESS | 13620 | RSS: Main: 185446400 08:18:06 INFO - PROCESS | 13620 | 08:18:09 INFO - PROCESS | 13620 | Cycle 1(1): loaded http://localhost:36977/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36977/tests/kraken/driver.html?testName=imaging-darkroom) 08:18:10 INFO - PROCESS | 13620 | RSS: Main: 221282304 08:18:10 INFO - PROCESS | 13620 | 08:18:13 INFO - PROCESS | 13620 | Cycle 1(1): loaded http://localhost:36977/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36977/tests/kraken/driver.html?testName=imaging-desaturate) 08:18:14 INFO - PROCESS | 13620 | RSS: Main: 217305088 08:18:14 INFO - PROCESS | 13620 | 08:18:17 INFO - PROCESS | 13620 | Cycle 1(1): loaded http://localhost:36977/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36977/tests/kraken/driver.html?testName=json-parse-financial) 08:18:17 INFO - PROCESS | 13620 | RSS: Main: 219885568 08:18:17 INFO - PROCESS | 13620 | 08:18:19 INFO - PROCESS | 13620 | Cycle 1(1): loaded http://localhost:36977/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36977/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:18:20 INFO - PROCESS | 13620 | RSS: Main: 206155776 08:18:20 INFO - PROCESS | 13620 | 08:18:21 INFO - PROCESS | 13620 | Cycle 1(1): loaded http://localhost:36977/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36977/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:18:22 INFO - PROCESS | 13620 | RSS: Main: 210624512 08:18:22 INFO - PROCESS | 13620 | 08:18:24 INFO - PROCESS | 13620 | Cycle 1(1): loaded http://localhost:36977/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36977/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:18:25 INFO - PROCESS | 13620 | RSS: Main: 208912384 08:18:25 INFO - PROCESS | 13620 | 08:18:28 INFO - PROCESS | 13620 | Cycle 1(1): loaded http://localhost:36977/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36977/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:18:28 INFO - PROCESS | 13620 | RSS: Main: 222531584 08:18:28 INFO - PROCESS | 13620 | 08:18:31 INFO - PROCESS | 13620 | Cycle 1(1): loaded http://localhost:36977/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36977/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:18:32 INFO - PROCESS | 13620 | RSS: Main: 223653888 08:18:32 INFO - PROCESS | 13620 | 08:18:33 INFO - PROCESS | 13620 | Cycle 1(1): loaded http://localhost:36977/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36977/tests/kraken/driver.html?testName=ai-astar) 08:18:34 INFO - PROCESS | 13620 | RSS: Main: 265895936 08:18:34 INFO - PROCESS | 13620 | 08:18:34 INFO - PROCESS | 13620 | __start_tp_report 08:18:34 INFO - PROCESS | 13620 | _x_x_mozilla_page_load 08:18:34 INFO - PROCESS | 13620 | _x_x_mozilla_page_load_details 08:18:34 INFO - PROCESS | 13620 | |i|pagename|runs| 08:18:34 INFO - PROCESS | 13620 | |0;ai-astar;108;116;113;114;115;113;117;113;113;115 08:18:34 INFO - PROCESS | 13620 | |1;audio-beat-detection;155;127;124;182;127;124;147;121;158;126 08:18:34 INFO - PROCESS | 13620 | |2;audio-dft;161;160;160;160;161;162;162;164;161;161 08:18:34 INFO - PROCESS | 13620 | |3;audio-fft;75;77;78;131;78;76;79;77;98;75 08:18:34 INFO - PROCESS | 13620 | |4;audio-oscillator;86;84;120;85;85;85;116;85;91;124 08:18:34 INFO - PROCESS | 13620 | |5;imaging-gaussian-blur;116;117;117;117;117;117;119;117;117;116 08:18:34 INFO - PROCESS | 13620 | |6;imaging-darkroom;146;146;147;147;147;145;147;146;146;146 08:18:34 INFO - PROCESS | 13620 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 08:18:34 INFO - PROCESS | 13620 | |8;json-parse-financial;65;64;66;63;64;65;65;63;64;64 08:18:34 INFO - PROCESS | 13620 | |9;json-stringify-tinderbox;64;65;65;65;65;64;66;65;66;65 08:18:34 INFO - PROCESS | 13620 | |10;stanford-crypto-aes;77;78;78;77;79;77;77;77;78;87 08:18:34 INFO - PROCESS | 13620 | |11;stanford-crypto-ccm;125;126;123;136;135;126;129;125;174;133 08:18:34 INFO - PROCESS | 13620 | |12;stanford-crypto-pbkdf2;163;166;173;169;170;162;163;165;168;168 08:18:34 INFO - PROCESS | 13620 | |13;stanford-crypto-sha256-iterative;71;70;68;69;67;71;66;67;68;66 08:18:34 INFO - PROCESS | 13620 | __end_tp_report 08:18:34 INFO - PROCESS | 13620 | __start_cc_report 08:18:34 INFO - PROCESS | 13620 | _x_x_mozilla_cycle_collect,1910 08:18:34 INFO - PROCESS | 13620 | __end_cc_report 08:18:34 INFO - PROCESS | 13620 | __startTimestamp1467386314162__endTimestamp 08:18:34 INFO - PROCESS | 13620 | 08:18:34 INFO - PROCESS | 13620 | ------- Summary: start ------- 08:18:34 INFO - PROCESS | 13620 | Number of tests: 14 08:18:34 INFO - PROCESS | 13620 | 08:18:34 INFO - PROCESS | 13620 | [#0] ai-astar Cycles:10 Average:113.70 Median:114.50 stddev:2.45 (2.1%) stddev-sans-first:1.50 08:18:34 INFO - PROCESS | 13620 | Values: 108.0 116.0 113.0 114.0 115.0 113.0 117.0 113.0 113.0 115.0 08:18:34 INFO - PROCESS | 13620 | 08:18:34 INFO - PROCESS | 13620 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:137.00 stddev:20.44 (14.9%) stddev-sans-first:20.86 08:18:34 INFO - PROCESS | 13620 | Values: 155.0 127.0 124.0 182.0 127.0 124.0 147.0 121.0 158.0 126.0 08:18:34 INFO - PROCESS | 13620 | 08:18:34 INFO - PROCESS | 13620 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 08:18:34 INFO - PROCESS | 13620 | Values: 161.0 160.0 160.0 160.0 161.0 162.0 162.0 164.0 161.0 161.0 08:18:34 INFO - PROCESS | 13620 | 08:18:34 INFO - PROCESS | 13620 | [#3] audio-fft Cycles:10 Average:84.40 Median:77.50 stddev:17.72 (22.9%) stddev-sans-first:18.46 08:18:34 INFO - PROCESS | 13620 | Values: 75.0 77.0 78.0 131.0 78.0 76.0 79.0 77.0 98.0 75.0 08:18:34 INFO - PROCESS | 13620 | 08:18:34 INFO - PROCESS | 13620 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:85.00 stddev:16.71 (19.7%) stddev-sans-first:17.32 08:18:34 INFO - PROCESS | 13620 | Values: 86.0 84.0 120.0 85.0 85.0 85.0 116.0 85.0 91.0 124.0 08:18:34 INFO - PROCESS | 13620 | 08:18:34 INFO - PROCESS | 13620 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 08:18:34 INFO - PROCESS | 13620 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 119.0 117.0 117.0 116.0 08:18:34 INFO - PROCESS | 13620 | 08:18:34 INFO - PROCESS | 13620 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 08:18:34 INFO - PROCESS | 13620 | Values: 146.0 146.0 147.0 147.0 147.0 145.0 147.0 146.0 146.0 146.0 08:18:34 INFO - PROCESS | 13620 | 08:18:34 INFO - PROCESS | 13620 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 08:18:34 INFO - PROCESS | 13620 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 08:18:34 INFO - PROCESS | 13620 | 08:18:34 INFO - PROCESS | 13620 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:64.50 stddev:0.95 (1.5%) stddev-sans-first:0.97 08:18:34 INFO - PROCESS | 13620 | Values: 65.0 64.0 66.0 63.0 64.0 65.0 65.0 63.0 64.0 64.0 08:18:34 INFO - PROCESS | 13620 | 08:18:34 INFO - PROCESS | 13620 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 08:18:34 INFO - PROCESS | 13620 | Values: 64.0 65.0 65.0 65.0 65.0 64.0 66.0 65.0 66.0 65.0 08:18:34 INFO - PROCESS | 13620 | 08:18:34 INFO - PROCESS | 13620 | [#10] stanford-crypto-aes Cycles:10 Average:78.50 Median:78.00 stddev:3.06 (3.9%) stddev-sans-first:3.20 08:18:34 INFO - PROCESS | 13620 | Values: 77.0 78.0 78.0 77.0 79.0 77.0 77.0 77.0 78.0 87.0 08:18:34 INFO - PROCESS | 13620 | 08:18:34 INFO - PROCESS | 13620 | [#11] stanford-crypto-ccm Cycles:10 Average:133.20 Median:131.00 stddev:15.04 (11.5%) stddev-sans-first:15.66 08:18:34 INFO - PROCESS | 13620 | Values: 125.0 126.0 123.0 136.0 135.0 126.0 129.0 125.0 174.0 133.0 08:18:34 INFO - PROCESS | 13620 | 08:18:34 INFO - PROCESS | 13620 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:168.00 stddev:3.53 (2.1%) stddev-sans-first:3.48 08:18:34 INFO - PROCESS | 13620 | Values: 163.0 166.0 173.0 169.0 170.0 162.0 163.0 165.0 168.0 168.0 08:18:34 INFO - PROCESS | 13620 | 08:18:34 INFO - PROCESS | 13620 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:1.89 (2.8%) stddev-sans-first:1.73 08:18:34 INFO - PROCESS | 13620 | Values: 71.0 70.0 68.0 69.0 67.0 71.0 66.0 67.0 68.0 66.0 08:18:34 INFO - PROCESS | 13620 | -------- Summary: end -------- 08:18:34 INFO - PROCESS | 13620 | 08:18:35 INFO - TEST-INFO | 13620: exit 0 08:18:35 INFO - TEST-OK | kraken | took 63299ms 08:18:35 INFO - SUITE-END | took 1181s 08:18:35 INFO - Completed test suite (00:19:41) 08:18:35 INFO - javascript benchmark 08:18:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2590.7927365810733, 2609.9999999999995, 2614.4901744159874, 2648.814582979191, 2656.89372425103, 4526.841560545382, 4598.885027874305, 4702.200625893598, 4705.106029854325, 4726.102040612285, 4650.837220697268, 4694.812207511704, 4702.741349225791, 4722.079194557063, 4727.267273572602, 4087.4686290782156, 4257.829686812532, 4325.134973005396, 4361.084172323815, 4436.44544431946, 4345.326474396474, 4380.189664911985, 4384.89037774055, 4394.187075391047, 4419.558044195571, 4212.9789351053205, 4235.9364609530885, 4259.3610958356185, 4277.315629499265, 4286.057067445157, 4225.2183346080765, 4244.363345498169, 4249.68127390447, 4277.97861010696, 4298.828046878121, 4255.0, 4262.211490874198, 4294.312909934395, 4300.22595932732, 4301.763403012833, 4569.702969306984, 4644.419447569054, 4661.953380466186, 4705.3647757552635, 4722.480527142012, 5071.239314102877, 5074.467180945984, 5082.288479612857, 5083.669561478492, 5090.720010399426, 5055.747212639353, 5102.0, 5114.820981265638, 5120.871978200537, 5132.0, 4559.566841150052, 4627.421572303462, 4669.7431641260055, 4670.322803193518, 4734.857954261378, 5155.097857874857, 5173.042987047333, 5173.275741396207, 5175.146100893386, 5178.0420622184265, 4820.517948205152, 4947.777350019258, 4949.82675606352, 4956.231784073474, 4960.603151747851, 4970.15507363749, 5010.674306170087, 5019.698818070854, 5026.070177017264, 5079.492050794891, 4980.153373926441, 4983.327250821165, 4983.676061056092, 4989.775460104304, 5039.319691841628, 4895.363602731622, 4916.434610019822, 4968.677035992721, 4974.253861920669, 4975.825846095369, 4286.014216730107, 4287.6355509782015, 4287.807048682755, 4316.050468896838, 4334.913301733947, 3723.3298006359114, 3738.2336620992633, 3754.9436758448646, 3785.962140378616, 3792.1088544192094, 4222.0, 4255.851045213402, 4257.446531950826, 4382.758948257876, 4396.384506169139, 4933.235348520985, 5035.697858128524, 5070.011347787146, 5080.542751152414, 5114.948850511447, 4385.978070109629, 4401.493828209733, 4414.1171765647, 4414.271645178574, 4446.221911165598, 4546.204414227563, 4565.406497155349, 4572.9314060289125, 4577.908441831145, 4627.930581041287, 4619.976900115478, 4683.718976861399, 4738.8341408050555, 4748.643851711066, 4767.332573439721, 4997.350344455198, 5027.622928280467, 5042.067217564762, 5046.394432668103, 5120.923186152285, 4730.763461826964, 4737.786799593958, 4757.524247575215, 4759.714417134983, 4790.688605240648, 4799.28010798383, 4909.828156014665, 4931.926021109614, 4959.380077490314, 4975.97992411562, 5012.749362531786, 5027.446980832178, 5036.345275114211, 5043.52086551777, 5082.390113186441, 4737.028909073701, 4863.173260545786, 4879.707217566957, 4886.438059623189, 4924.803007879788, 4835.8065677372515, 4880.097182021337, 4915.582175514978, 4938.259261110862, 4971.428285747041, 4844.806207751651, 4849.0, 4858.149823780895, 4859.95140048595, 4887.315775791463, 4941.209406494943, 4957.752112394438, 4961.08219979305, 4965.4289756677, 4998.925016124688, 4699.130660827758, 4772.141014617402, 4821.975890120527, 4822.541858523435, 4834.081524510332], "value": 4613.101216120801, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [555.3252797850612, 557.5539568345325, 562.5640128900104, 567.4042255631585, 575.7178982298673, 27324.86337568312, 27780.0, 30032.399352012948, 30032.69967300329, 30099.09702708922, 30159.84920075402, 43927.78036109815, 45207.547924520746, 45551.77224113875, 45631.77184114075, 7792.961035194816, 7910.169432209622, 7911.2088791121005, 7915.643796029192, 7919.287264146225, 7754.302112809846, 7856.292933635971, 7862.01724784402, 7863.724769633064, 7873.763787086368, 7754.922450775504, 7782.416318776086, 7783.844323113534, 7784.0, 7788.4937479063965, 7868.213178682115, 7910.683572657087, 7924.524528528249, 7929.96035019827, 7940.563269020202, 7808.804779880492, 7822.295993360625, 7850.803729906741, 7869.291763741291, 7869.724559640385, 38571.0, 38930.80534597337, 38992.80503597464, 38997.61002389968, 39014.609853901384, 3128.562001319817, 3174.3175217328153, 3206.118317462693, 3248.6751324867323, 3395.6434574369828, 29107.708922910922, 29566.556501652492, 29881.727734047177, 30394.84802575995, 30988.38023239545, 3055.159831046458, 3299.7360211183286, 3330.933381332384, 3344.4816053511745, 3375.088726043979, 201962.0, 258313.0, 260256.0, 260529.0, 261816.0, 27322.726772732018, 56507.43492565022, 57242.0, 57295.713521432124, 57310.994115205765, 28352.43295134086, 29884.402311954073, 29891.0, 29891.551626725617, 29948.40103197924, 13300.600981970556, 13480.662983425493, 13535.59393218205, 13563.05058645905, 13583.185008899498, 11288.887111128948, 11367.09063274936, 11377.715557111138, 11377.943110284396, 11385.658430247106, 7960.2039796019935, 7987.56068416231, 8018.599070046591, 8091.39314551411, 8112.472689275178, 3139.7802153849466, 3176.1097401364646, 3184.1402821238134, 3196.1370429983776, 3230.3054843208824, 884.5356188001222, 891.5542228885557, 897.9102089791099, 907.6233363154349, 1017.893121222261, 27625.86187069092, 28291.85046206651, 28468.145955621363, 28956.828237881822, 29341.359277665113, 945.3524335829978, 963.4219468319093, 978.0610613810821, 1006.3106771861299, 1033.6278939581744, 14823.77764333536, 15185.468508602145, 15302.770458443132, 15314.157721325211, 15378.461753838563, 409537.0, 468906.0, 712646.0, 714543.0, 727478.0, 49972.50027499751, 50530.49469505331, 50685.49314506882, 50691.0, 50774.49225507698, 1071.052118874786, 1161.5992482593492, 1201.1531870031606, 1209.6975756060986, 1220.9389530523615, 25771.871140644176, 29474.410511789214, 29539.85230073836, 29997.400051999273, 30008.24979375533, 41503.58496415118, 42053.579464204966, 42179.945501361486, 42199.367009495494, 42233.57766422296, 312462.0, 319181.0, 319676.0, 320011.0, 321358.0, 22928.0, 25406.872965635794, 25579.87210064012, 25618.0, 25994.61008084918, 40793.184136316515, 41071.38392924049, 41186.0, 41460.0, 42438.5756142447, 34863.0, 35471.82264088663, 35790.821045894605, 35896.0, 36327.27345453129, 36214.0, 36415.27169456649, 36426.27147457089, 36766.0, 37131.814340928126, 35645.0, 35655.64344356627, 37079.6292037087, 37812.81093594514, 37857.2428551433, 30833.845830770704, 33543.47567503282, 33620.1594960128, 34065.0, 34094.31811363709, 25746.742532575183, 25949.091781787545, 25958.610620840325, 26117.608235876098, 26395.0], "value": 16629.28534212413, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.48964184604324, 368.7142464589942, 374.52622432622735, 384.2085304273197, 389.81094169327855, 16250.83749162508, 17378.13109344534, 17966.730499042525, 18211.544711382223, 18263.17815698295, 16667.91666041671, 17228.82771172288, 17279.222434990425, 17492.562685932826, 17499.037552934584, 5239.816606418766, 5390.5418039466695, 5430.809921652743, 5433.076377015897, 5433.347998240217, 3882.456456096149, 3932.9016774580577, 5298.602604804636, 6329.841753956165, 6447.226332840066, 6310.968445157768, 6345.270293916189, 6349.650769207692, 6374.904376434334, 6379.904301435482, 6134.631922084689, 6141.447269745744, 6164.167837341946, 6310.179676642053, 6311.936880631227, 5414.566834653218, 5516.531094856942, 5558.416366281523, 5564.1931919871795, 5567.8608034799045, 20606.27878024262, 21073.26243581467, 21117.366479005654, 21380.89309553458, 21931.780682193134, 1739.7564340992271, 1998.8500862435376, 2090.4669309326177, 2187.704659870913, 2334.6031174700342, 9554.61781528738, 9691.51542422876, 9807.803843923153, 9819.0, 9884.851727224097, 1769.9911500442415, 1843.5298998755231, 1847.7597912271453, 1852.3609354772582, 1855.4526414707693, 68519.31480685179, 69559.99999999949, 69735.65132174306, 69755.65122174408, 70077.64961175213, 10074.639923610219, 10176.898231017743, 10315.226358023028, 10412.895871041344, 10528.0, 14036.087654302437, 14065.015448918477, 14142.434302627986, 14179.574612761427, 14186.219757913414, 7159.463040272, 7468.589227592534, 7577.158565537923, 7649.502782319131, 7656.808579785438, 7192.604406757574, 7195.748148814766, 7357.963210183915, 7364.926350736424, 7420.962895185489, 4321.222180007629, 4404.2512772828695, 4469.508354081048, 4509.0, 4565.817367305271, 1789.329001624391, 1839.6596629623562, 1898.4399602117132, 1911.2832687742098, 1937.457511896643, 779.174075479993, 898.23201163006, 912.6440688131634, 952.9809403811885, 971.7667759737612, 16560.254788534545, 17245.827541724422, 17388.65222695539, 17717.11414429299, 17745.201465934064, 848.2154007542998, 857.3484152044491, 864.984585914817, 871.0810095349341, 931.4830269200659, 9404.429240545383, 9851.50742462874, 9852.605895764089, 9854.11312981835, 9867.210623150131, 395266.0, 398385.0, 398912.0, 418617.0, 424242.0, 65841.0, 82352.58823705843, 88206.0, 89910.0, 91160.54419727859, 889.7997950461095, 938.9201917837061, 946.5645802930729, 988.3081842710131, 991.4150651115876, 13920.164790112625, 15404.0, 16136.757948631015, 16343.509694709177, 16598.41905533349, 37290.44064339092, 37687.0, 37822.81088594539, 38513.80743096267, 38605.0, 54345.72827135839, 54913.0, 56417.43582564286, 56466.71766641141, 57098.14352784795, 7613.581253030915, 7658.119316278699, 7877.881831772643, 7944.126146124037, 8040.437169398086, 10382.42896640692, 11663.825042624538, 11678.474468649101, 11709.824352634547, 11858.525658973544, 10006.69979900604, 10159.187265018929, 10328.431936243578, 10384.26644324266, 10453.790924181625, 9490.525473726148, 10318.0, 10418.947905260426, 10772.730681732706, 10779.622713205, 9585.472798996123, 9690.224782017282, 9926.10665040121, 10237.283390162616, 10419.479026048819, 7335.816604584715, 7835.168329424967, 7914.287714105758, 7924.48490848093, 7998.560079195468, 7874.0, 9199.632014719336, 10141.188704903738, 10475.94762026185, 10794.946025269823], "value": 8479.126001691251, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1377.9448822047123, 1423.672555312278, 1466.8386477487481, 1652.5042487253813, 1657.8010638723356, 7356.301151390616, 7804.219578042207, 7845.529268243909, 7845.725399611015, 7850.254225848543, 6935.687894044768, 7466.0, 7686.077670679512, 7784.494007889483, 7791.805204869881, 2176.1513009926143, 2211.281333566589, 2211.4139752965475, 2212.23677831148, 2214.2914267434426, 2142.9464263393384, 2188.485705859122, 2202.735671719396, 2203.636399993999, 2208.4810069633622, 1917.405604262676, 2102.8317734581196, 2162.19998600518, 2171.6742488626674, 2198.0218802632835, 2162.416147640144, 2168.9240876569324, 2192.9780702193093, 2193.6928829963817, 2213.0262684418803, 2207.9448013799624, 2215.2578886073184, 2215.7562668106493, 2216.8337374696803, 2217.9001944912357, 8038.356931445471, 8044.0, 8046.839063218761, 8047.47691400063, 8049.798755031113, 4404.977975110104, 4499.595036446735, 4525.2533332000185, 4549.727016379028, 4554.726716397026, 2809.4240680660414, 2833.4191490744347, 2929.311611771232, 2931.5456104303867, 2938.0598208573265, 893.7765558610347, 917.4862077236769, 922.547951503765, 936.2884208001899, 936.4100616611491, 10371.0, 10372.118369938564, 10394.9480252599, 10405.167586593054, 10427.791444171075, 4068.3694027425795, 4176.791160441966, 4343.543927887589, 4351.717138385995, 4356.520782713899, 8821.647134114692, 8853.335999800041, 8892.421992570462, 8897.466152030898, 8901.910980890238, 4648.395708557866, 4654.488006319302, 4655.837045703384, 4656.231721765871, 4658.254679251304, 4167.74993500391, 4219.831206751695, 4237.957620423756, 4238.237117318912, 4240.872773816791, 3733.4213196954515, 3780.243951209769, 3810.8856734298015, 3856.6914646828186, 3860.942085868714, 1070.1224995503612, 1183.1185766603762, 1197.4192516629428, 1205.5358686905604, 1213.6298428979246, 619.9225096862892, 775.143466469543, 849.5285116760134, 868.5961028121827, 871.7689812199773, 5135.563477104488, 5306.389765177054, 5367.624266301322, 5398.784048638089, 5458.0, 882.2280504558511, 896.1486587741672, 904.4754042655244, 905.2034209895381, 912.2063804490136, 3591.856325746941, 3645.343838109166, 3651.087228192952, 3682.9815850920572, 3698.981505092457, 9631.759206019906, 9910.752231194278, 9950.55222514974, 10102.69691909244, 10107.7473063174, 9751.951240243754, 10043.748906277402, 10054.09513143806, 10058.195344372432, 10058.497075146213, 7435.4795164337975, 7443.069616297963, 7540.509866858637, 7556.24437556251, 7623.656935437919, 5250.579953603627, 5257.763400647056, 5258.395284542174, 5300.0, 5312.043832110257, 9120.589573469077, 9134.771630709285, 9183.127602877716, 9356.204722598382, 9403.059694030542, 9135.949365823015, 9466.668666596635, 9488.383255088396, 9523.52382380892, 9564.330496865152, 6745.460363170836, 6986.860262794614, 7007.089078419976, 7033.226345102137, 7069.399101076466, 7893.763187104396, 7909.288164065261, 7962.08436029864, 7969.521828690297, 7974.122846486998, 6653.5009874260595, 6870.381665650116, 6885.4835887309655, 6995.720171193096, 7127.287271272831, 6580.638064906476, 6641.302663220486, 6766.018927255619, 6990.755323563651, 7065.540739851893, 6192.318844927145, 6201.069839524108, 6232.002879539252, 6281.748730050746, 6301.873962520633, 4330.566943305645, 4396.34054891756, 4422.226110430597, 4439.445069366329, 4487.304467807495, 4597.862064138081, 4618.722876627413, 4652.255639097728, 4711.787969541448, 4746.33551302811], "value": 4181.8486472262975, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.3185618228617, 299.20859327079876, 303.7645824486024, 305.4486651593872, 308.42940559964063, 4558.0, 4758.571728544431, 4783.736894470802, 4807.23084306511, 4817.9277310840325, 4575.428071491064, 4723.90552188956, 4736.952630473695, 4743.976280118603, 4759.881002974918, 3729.608391118934, 3740.2706472237924, 3742.719296052807, 3745.119896824258, 3746.2132952080096, 3572.4819901114324, 3615.9638403616023, 3748.269087527933, 3750.624937506241, 3759.624037596232, 3704.38859096294, 3715.420946097911, 3721.79530125843, 3736.794476303802, 3742.419924911643, 3714.182879766447, 3715.5541335039698, 3716.3682174030478, 3729.962700372989, 3739.364308067608, 3298.367308182465, 3298.422776014188, 3300.141963089614, 3302.6367099619024, 3313.122022663996, 4453.688241823073, 4638.281066434708, 4645.907081858378, 4668.4594083952215, 4668.976655116737, 4251.766152861592, 4260.616544511009, 4261.595148460891, 4271.594198551133, 4284.0, 4781.282807578891, 4968.826091086795, 4977.800887964477, 4979.775910084055, 4982.7259500727805, 3554.2713743682484, 3588.9282214355567, 3590.2281009583066, 3590.35373632746, 3591.44332628443, 5171.689698618095, 5202.973985130088, 5224.320838290998, 5225.477452254782, 5229.660072095339, 3636.4181730922924, 3645.85416583339, 3648.9817550912076, 3657.3416784978426, 3661.5972243053243, 3564.2336897567147, 3644.3075815594952, 3703.7222208334483, 3709.7588656737225, 3732.4774531565604, 4164.083901541656, 4226.725262857904, 4232.30167022444, 4234.047339348622, 4237.470316210473, 5003.799848006039, 5011.6241281904, 5013.849584512471, 5015.0, 5022.192010876081, 1184.8045072562932, 1229.4467489629524, 1271.2753730373784, 1274.5602767045355, 1277.514544473113, 833.1377024779324, 848.3891598049395, 856.498948115347, 861.7500924731883, 863.3826813828143, 4437.667174961891, 4437.667174961891, 4440.800163992628, 4441.933370999438, 4456.977715111404, 5124.56441202502, 5128.974355128201, 5136.280920671109, 5140.922886156711, 5142.151544995034, 4418.668599855024, 4424.778761061934, 4429.202743506135, 4429.446319210098, 4431.357453169272, 2602.6746656667915, 2753.7934654900964, 2755.7106503817213, 2756.724327567227, 2758.544840101401, 4855.6115510759055, 4857.927131093036, 4865.5620994109995, 4868.586170175575, 4879.1461494238365, 5018.84943451697, 5296.443873393316, 5300.522952934254, 5301.469853014745, 5303.655262407931, 4855.5387238212315, 4879.194932836042, 4888.780004899717, 4891.828785992473, 4902.142125128088, 5186.769689033752, 5190.97404512975, 5193.896122077613, 5202.687838729688, 5207.453217412269, 4762.904741905073, 5073.260439362851, 5088.0, 5116.027954688598, 5129.307543481582, 4831.202851529459, 4836.863337115705, 4840.177169881199, 4845.200541910545, 4892.779824907817, 3647.5258216431694, 3655.360311945452, 3680.6871415928877, 3689.4465830125696, 3690.1512652090705, 5005.5745261653165, 5184.9740751296, 5187.844364669066, 5193.8836697980905, 5204.9739751301, 5041.747912604282, 5056.0, 5058.898822023612, 5060.1903695408555, 5066.328111723049, 5011.974940125276, 5037.798488060436, 5046.29351890743, 5047.217681259411, 5048.217526283432, 4847.442544107473, 4969.130402179677, 4981.850544483671, 4984.40187177541, 4993.776524751459, 5031.6729412588065, 5060.671056381323, 5065.670731402447, 5065.797368105234, 5075.847724568269, 4961.6030717543235, 4970.826021089245, 4975.353204083591, 4981.4769449207315, 4997.875053123701], "value": 3778.9846823601947, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.8642271545692, 680.9829754256144, 688.1570076656097, 717.3328804212081, 741.5128052412151, 12590.685232869182, 13735.939609058647, 13780.862191378108, 13863.722725545496, 13880.16718996861, 12339.259644421341, 12420.0, 13754.312284385791, 13781.724365512684, 13796.241206733626, 780.4965797060893, 789.4158322841114, 795.3796039089519, 796.625585974594, 796.7928338631968, 635.9268684101318, 778.6534991928594, 802.0575823407502, 810.4084018666377, 814.1288820961573, 849.1169184048582, 849.2484151525882, 851.0808327006848, 851.5784686580151, 851.9787005324855, 657.5265808617787, 844.8268105038452, 846.3525403066659, 846.7840700621364, 847.1401527449643, 590.8345663214307, 600.7536909866934, 609.7591451376682, 609.8170548835376, 609.9664518451483, 13441.126326788728, 13521.526746563823, 13532.59402217935, 13547.864521354759, 13564.864351356458, 12078.516859325617, 12336.321502317369, 12484.625461236177, 12620.432080556306, 12803.679908002281, 10913.23607347478, 11025.0, 11317.377544235063, 11684.474198660995, 12054.69863253417, 4131.607497287753, 4132.2561938850995, 4141.855035073758, 4204.621584057419, 4241.406203131564, 60322.39677603212, 61443.385566144214, 61777.0, 62864.685676571324, 63046.0543091854, 10277.075063244343, 10326.380417174994, 10396.272260941812, 10464.63373781914, 10480.318779279323, 19130.52173695641, 19134.0, 19194.904025480064, 19208.327708530414, 19211.135498902582, 6731.831704207434, 6769.559978601474, 6808.217055038734, 6888.862222755517, 7112.395446387115, 3744.8876533704033, 3746.7189960753053, 3783.5270591176104, 3807.124361396894, 3852.7110466715108, 2780.569011803174, 2877.5971364009056, 2880.495913215179, 2881.4957382457987, 2882.553204253344, 500.52950226786703, 501.38079471852234, 508.2503307621229, 508.77613849905924, 512.18562485648, 529.8940211957624, 539.3500831498036, 553.3000754046135, 554.7420449491007, 561.4750208555014, 7474.0, 7680.231976802387, 7703.229677032252, 8015.639296231683, 8041.914341563931, 528.3448523830499, 534.2627174499244, 546.7703564502918, 554.4621716934568, 555.9714528123021, 3687.483752274684, 3726.7701658452647, 3837.6737977271687, 3897.395903634941, 3908.863189788344, 53925.460745392826, 53985.0, 54019.45980540223, 55896.0, 79938.0, 83578.0, 84258.57870710608, 85581.0, 86051.0, 86470.56764716136, 41419.792901035304, 41507.377389339184, 46089.30866037012, 52891.0, 70581.2941870585, 6646.90029649546, 6993.440524758109, 7173.1392232932385, 7180.210176880434, 7258.165310989304, 43239.135217296105, 43431.34852977144, 44176.55823441724, 44303.0, 45491.772541137085, 57841.42158578528, 60114.699426502586, 60373.0, 60596.697016514634, 60599.69700151471, 9495.715128546155, 9549.713508594754, 9667.806643866943, 9674.419534827934, 9825.55784989663, 10509.31689440184, 10639.468026598794, 10675.946620266848, 10716.0, 10748.623798167027, 9587.712368628952, 9755.512224388895, 9784.461854597781, 9857.0, 9858.55636496345, 9271.536423178679, 9359.812803743751, 9604.183644390305, 9682.179285263783, 9698.660546880825, 9505.28710346713, 9661.447081551638, 9691.563879625293, 9777.467666774595, 9970.451625160686, 8252.0, 8375.74088487104, 8390.0, 8524.488530688179, 8609.096044915445, 7909.24862138096, 8238.176182381714, 8310.293625041939, 8500.234978851686, 8532.786680333042], "value": 6195.8896834014, "unit": "score"}], "name": "dromaeo_css", "value": 6319.539935962588, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 116.0, 113.0, 114.0, 115.0, 113.0, 117.0, 113.0, 113.0, 115.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 124.0, 182.0, 127.0, 124.0, 147.0, 121.0, 158.0, 126.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 160.0, 161.0, 162.0, 162.0, 164.0, 161.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 78.0, 131.0, 78.0, 76.0, 79.0, 77.0, 98.0, 75.0], "value": 84.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 120.0, 85.0, 85.0, 85.0, 116.0, 85.0, 91.0, 124.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 119.0, 117.0, 117.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 147.0, 145.0, 147.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 63.0, 64.0, 65.0, 65.0, 63.0, 64.0, 64.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 64.0, 66.0, 65.0, 66.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 78.0, 78.0, 77.0, 79.0, 77.0, 77.0, 77.0, 78.0, 87.0], "value": 78.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 126.0, 123.0, 136.0, 135.0, 126.0, 129.0, 125.0, 174.0, 133.0], "value": 133.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 166.0, 173.0, 169.0, 170.0, 162.0, 163.0, 165.0, 168.0, 168.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 68.0, 69.0, 67.0, 71.0, 66.0, 67.0, 68.0, 66.0], "value": 68.3, "unit": "score"}], "name": "kraken", "value": 1528.8, "alertThreshold": 2.0}]} 08:18:35 INFO - Return code: 0 08:18:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:18:35 INFO - # TBPL SUCCESS # 08:18:35 INFO - Running post-action listener: _resource_record_post_action 08:18:35 INFO - ##### 08:18:35 INFO - ##### Finished run-tests step (success) 08:18:35 INFO - ##### 08:18:35 INFO - Running post-run listener: _resource_record_post_run 08:18:35 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 556900352; Read time: 12; Write time: 443692 08:18:35 INFO - TinderboxPrint: CPU usage
12.9% 08:18:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:18:35 INFO - TinderboxPrint: I/O write bytes / time
556,900,352 / 443,692 08:18:35 INFO - TinderboxPrint: CPU idle
8,324.4 (87.1%) 08:18:35 INFO - TinderboxPrint: CPU user
1,196.2 (12.5%) 08:18:35 INFO - TinderboxPrint: Swap in / out
0 / 0 08:18:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 245800960; Read time: 0; Write time: 228896 08:18:35 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 289431552; Read time: 0; Write time: 207092 08:18:36 INFO - Running post-run listener: _upload_blobber_files 08:18:36 INFO - Blob upload gear active. 08:18:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:18:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:18:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:18:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:18:36 INFO - (blobuploader) - INFO - Open directory for files ... 08:18:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:18:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:18:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:18:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:18:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:18:39 INFO - (blobuploader) - INFO - Done attempting. 08:18:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:18:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:18:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:18:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:18:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:18:40 INFO - (blobuploader) - INFO - Done attempting. 08:18:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:18:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:18:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:18:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:18:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:18:41 INFO - (blobuploader) - INFO - Done attempting. 08:18:41 INFO - (blobuploader) - INFO - Iteration through files over. 08:18:41 INFO - Return code: 0 08:18:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:18:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:18:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cb9e04de0a9af99eb06ac5db9f415150121e3259f127e47913a3b97073d387da034fc7b46c99d8ac6037b805dcc0b9d0e659f09b1faa1334ecbfda289456c2fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20c4c37d7bd675f7ab3a302806618ae7621cae8a527441f524c841516ff481e9073371cf621dc5e0187a8142f011c5f9cc9f618a770e2e2cb81c2684d83ecc6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2f17e12f724d74837641755233362fbdbc4477b10940faa1921fc3013e4c15d9eb677bd55948f56d8e355a26e06fc07d6fcb5f0c8fe6593ead5871760f962834"} 08:18:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:18:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:18:41 INFO - Contents: 08:18:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cb9e04de0a9af99eb06ac5db9f415150121e3259f127e47913a3b97073d387da034fc7b46c99d8ac6037b805dcc0b9d0e659f09b1faa1334ecbfda289456c2fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20c4c37d7bd675f7ab3a302806618ae7621cae8a527441f524c841516ff481e9073371cf621dc5e0187a8142f011c5f9cc9f618a770e2e2cb81c2684d83ecc6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2f17e12f724d74837641755233362fbdbc4477b10940faa1921fc3013e4c15d9eb677bd55948f56d8e355a26e06fc07d6fcb5f0c8fe6593ead5871760f962834"} 08:18:41 INFO - Running post-run listener: copy_logs_to_upload_dir 08:18:41 INFO - Copying logs to upload dir... 08:18:41 INFO - mkdir: /builds/slave/test/build/upload/logs 08:18:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.628385 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-01 08:18:41.016437) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 08:18:41.020069) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cb9e04de0a9af99eb06ac5db9f415150121e3259f127e47913a3b97073d387da034fc7b46c99d8ac6037b805dcc0b9d0e659f09b1faa1334ecbfda289456c2fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20c4c37d7bd675f7ab3a302806618ae7621cae8a527441f524c841516ff481e9073371cf621dc5e0187a8142f011c5f9cc9f618a770e2e2cb81c2684d83ecc6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2f17e12f724d74837641755233362fbdbc4477b10940faa1921fc3013e4c15d9eb677bd55948f56d8e355a26e06fc07d6fcb5f0c8fe6593ead5871760f962834"} build_url:https://queue.taskcluster.net/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011336 build_url: 'https://queue.taskcluster.net/v1/task/X-EYbTIiTlOPAGR4xj5ULw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cb9e04de0a9af99eb06ac5db9f415150121e3259f127e47913a3b97073d387da034fc7b46c99d8ac6037b805dcc0b9d0e659f09b1faa1334ecbfda289456c2fc", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/20c4c37d7bd675f7ab3a302806618ae7621cae8a527441f524c841516ff481e9073371cf621dc5e0187a8142f011c5f9cc9f618a770e2e2cb81c2684d83ecc6d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2f17e12f724d74837641755233362fbdbc4477b10940faa1921fc3013e4c15d9eb677bd55948f56d8e355a26e06fc07d6fcb5f0c8fe6593ead5871760f962834"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 08:18:41.046405) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 08:18:41.046764) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1467385068.555506-679199795 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 08:18:41.130146) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 08:18:41.130529) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 08:18:41.130922) ========= ========= Total master_lag: 0.17 =========